[INFO] fetching crate memfaultd 1.26.1...
[INFO] testing memfaultd-1.26.1 against try#0abe69e6c16114311cc2700e972492e64d69c28f for pr-154065-1
[INFO] extracting crate memfaultd 1.26.1 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate memfaultd 1.26.1
[INFO] finished tweaking crates.io crate memfaultd 1.26.1
[INFO] tweaked toml for crates.io crate memfaultd 1.26.1 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate memfaultd 1.26.1 on toolchain 0abe69e6c16114311cc2700e972492e64d69c28f
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate memfaultd 1.26.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 30d19451141d3998846faf0ca06bdcf86863611cee059a80b19c253247e2bad5
[INFO] running `Command { std: "docker" "start" "-a" "30d19451141d3998846faf0ca06bdcf86863611cee059a80b19c253247e2bad5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "30d19451141d3998846faf0ca06bdcf86863611cee059a80b19c253247e2bad5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "30d19451141d3998846faf0ca06bdcf86863611cee059a80b19c253247e2bad5", kill_on_drop: false }`
[INFO] [stdout] 30d19451141d3998846faf0ca06bdcf86863611cee059a80b19c253247e2bad5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 96c245cb34f1c69fd0d3e1a3f3708d55ed828f61b9c25bd4874cfb7b9d16f792
[INFO] running `Command { std: "docker" "start" "-a" "96c245cb34f1c69fd0d3e1a3f3708d55ed828f61b9c25bd4874cfb7b9d16f792", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.93
[INFO] [stderr]    Compiling libc v0.2.180
[INFO] [stderr]    Compiling pin-project-lite v0.2.13
[INFO] [stderr]    Compiling serde v1.0.197
[INFO] [stderr]    Compiling stable_deref_trait v1.2.0
[INFO] [stderr]    Compiling slab v0.4.9
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]    Compiling log v0.4.26
[INFO] [stderr]    Compiling litemap v0.7.4
[INFO] [stderr]    Compiling pkg-config v0.3.30
[INFO] [stderr]    Compiling itoa v1.0.10
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling equivalent v1.0.1
[INFO] [stderr]    Compiling smallvec v1.13.1
[INFO] [stderr]    Compiling icu_locid_transform_data v1.5.0
[INFO] [stderr]    Compiling rustls-pki-types v1.11.0
[INFO] [stderr]    Compiling http v1.2.0
[INFO] [stderr]    Compiling icu_properties_data v1.5.0
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling hashbrown v0.14.3
[INFO] [stderr]    Compiling libz-sys v1.1.12
[INFO] [stderr]    Compiling quote v1.0.35
[INFO] [stderr]    Compiling syn v2.0.98
[INFO] [stderr]    Compiling tracing-core v0.1.32
[INFO] [stderr]    Compiling paste v1.0.12
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling icu_normalizer_data v1.5.0
[INFO] [stderr]    Compiling rustls v0.23.22
[INFO] [stderr]    Compiling indexmap v2.2.5
[INFO] [stderr]    Compiling winnow v0.5.40
[INFO] [stderr]    Compiling tracing v0.1.40
[INFO] [stderr]    Compiling tower-service v0.3.2
[INFO] [stderr]    Compiling getrandom v0.2.12
[INFO] [stderr]    Compiling socket2 v0.5.6
[INFO] [stderr]    Compiling mio v1.0.3
[INFO] [stderr]    Compiling rustversion v1.0.12
[INFO] [stderr]    Compiling bitflags v2.4.2
[INFO] [stderr]    Compiling walkdir v2.3.3
[INFO] [stderr]    Compiling cfg_aliases v0.2.1
[INFO] [stderr]    Compiling thiserror v1.0.63
[INFO] [stderr]    Compiling portable-atomic v1.13.0
[INFO] [stderr]    Compiling ryu v1.0.17
[INFO] [stderr]    Compiling serde_json v1.0.114
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling rmp v0.8.11
[INFO] [stderr]    Compiling memfaultc-sys v1.26.1
[INFO] [stderr]    Compiling nix v0.31.1
[INFO] [stderr]    Compiling flate2 v1.0.31
[INFO] [stderr]    Compiling toml_edit v0.21.1
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling webpki-roots v0.26.8
[INFO] [stderr]    Compiling psm v0.1.21
[INFO] [stderr]    Compiling aho-corasick v1.0.1
[INFO] [stderr]    Compiling procfs v0.18.0
[INFO] [stderr]    Compiling argh_shared v0.1.10
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling ciborium-io v0.2.1
[INFO] [stderr]    Compiling zip v1.1.4
[INFO] [stderr]    Compiling signal-hook v0.3.15
[INFO] [stderr]    Compiling eyre v0.6.8
[INFO] [stderr]    Compiling regex-syntax v0.8.2
[INFO] [stderr]    Compiling half v1.8.2
[INFO] [stderr]    Compiling ciborium-ll v0.2.1
[INFO] [stderr]    Compiling strum_macros v0.24.3
[INFO] [stderr]    Compiling argh_derive v0.1.10
[INFO] [stderr]    Compiling synstructure v0.13.1
[INFO] [stderr]    Compiling rustls-webpki v0.102.8
[INFO] [stderr]    Compiling proc-macro-crate v3.1.0
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling regex-automata v0.4.3
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling spinning_top v0.3.0
[INFO] [stderr]    Compiling num_cpus v1.15.0
[INFO] [stderr]    Compiling zerofrom-derive v0.1.5
[INFO] [stderr]    Compiling serde_derive v1.0.197
[INFO] [stderr]    Compiling yoke-derive v0.7.5
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling zerovec-derive v0.10.3
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling icu_provider_macros v1.5.0
[INFO] [stderr]    Compiling tokio-macros v2.5.0
[INFO] [stderr]    Compiling pin-project-internal v1.1.9
[INFO] [stderr]    Compiling zerofrom v0.1.5
[INFO] [stderr]    Compiling yoke v0.7.5
[INFO] [stderr]    Compiling zerocopy-derive v0.7.35
[INFO] [stderr]    Compiling zerovec v0.10.4
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling tokio v1.43.1
[INFO] [stderr]    Compiling zerocopy v0.7.35
[INFO] [stderr]    Compiling pin-project v1.1.9
[INFO] [stderr]    Compiling num_enum_derive v0.7.3
[INFO] [stderr]    Compiling tinystr v0.7.6
[INFO] [stderr]    Compiling icu_locid v1.5.0
[INFO] [stderr]    Compiling icu_collections v1.5.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.20
[INFO] [stderr]    Compiling icu_provider v1.5.0
[INFO] [stderr]    Compiling scroll_derive v0.11.1
[INFO] [stderr]    Compiling thiserror-impl v1.0.63
[INFO] [stderr]    Compiling icu_locid_transform v1.5.0
[INFO] [stderr]    Compiling scroll v0.11.0
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling num_enum v0.7.3
[INFO] [stderr]    Compiling signal-hook-registry v1.4.1
[INFO] [stderr]    Compiling is-terminal v0.4.12
[INFO] [stderr]    Compiling rustls-pemfile v2.2.0
[INFO] [stderr]    Compiling thread_local v1.1.7
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling icu_properties v1.5.1
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling http-body-util v0.1.2
[INFO] [stderr]    Compiling memfaultd v1.26.1 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling indenter v0.3.3
[INFO] [stderr]    Compiling chunked_transfer v1.4.1
[INFO] [stderr]    Compiling web-time v1.1.0
[INFO] [stderr]    Compiling nonzero_ext v0.3.0
[INFO] [stderr]    Compiling ascii v1.1.0
[INFO] [stderr]    Compiling either v1.8.1
[INFO] [stderr]    Compiling plain v0.2.3
[INFO] [stderr]    Compiling crc-catalog v2.2.0
[INFO] [stderr]    Compiling ipnet v2.9.0
[INFO] [stderr]    Compiling governor v0.10.4
[INFO] [stderr]    Compiling crc v3.0.1
[INFO] [stderr]    Compiling tiny_http v0.12.0
[INFO] [stderr]    Compiling goblin v0.7.1
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling gimli v0.31.1
[INFO] [stderr]    Compiling icu_normalizer v1.5.0
[INFO] [stderr]    Compiling hyper v1.1.0
[INFO] [stderr]    Compiling chrono v0.4.39
[INFO] [stderr]    Compiling idna_adapter v1.2.0
[INFO] [stderr]    Compiling tower v0.4.13
[INFO] [stderr]    Compiling idna v1.0.3
[INFO] [stderr]    Compiling tokio-rustls v0.26.1
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling url v2.5.4
[INFO] [stderr]    Compiling rmp-serde v1.1.1
[INFO] [stderr]    Compiling hyper-util v0.1.3
[INFO] [stderr]    Compiling uuid v1.16.0
[INFO] [stderr]    Compiling ciborium v0.2.1
[INFO] [stderr]    Compiling serde_bytes v0.11.9
[INFO] [stderr]    Compiling memfault-ssf v1.26.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling hyper-rustls v0.27.5
[INFO] [stderr]    Compiling procfs-core v0.18.0
[INFO] [stderr]    Compiling reqwest v0.12.5
[INFO] [stderr]    Compiling stderrlog v0.6.0
[INFO] [stderr]    Compiling syslog_loose v0.21.0
[INFO] [stderr]    Compiling regex v1.10.2
[INFO] [stderr]    Compiling threadpool v1.8.1
[INFO] [stderr]    Compiling serde_repr v0.1.12
[INFO] [stderr]    Compiling strum v0.24.1
[INFO] [stderr]    Compiling argh v0.1.10
[INFO] [stderr]    Compiling rmpv v1.0.0
[INFO] [stderr]    Compiling kernlog v0.3.1
[INFO] [stderr]    Compiling shuteye v0.3.3
[INFO] [stderr]    Compiling urlencoding v2.1.2
[INFO] [stderr]    Compiling fs_extra v1.3.0
[INFO] [stderr]    Compiling take_mut v0.2.2
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3m 03s
[INFO] running `Command { std: "docker" "inspect" "96c245cb34f1c69fd0d3e1a3f3708d55ed828f61b9c25bd4874cfb7b9d16f792", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "96c245cb34f1c69fd0d3e1a3f3708d55ed828f61b9c25bd4874cfb7b9d16f792", kill_on_drop: false }`
[INFO] [stdout] 96c245cb34f1c69fd0d3e1a3f3708d55ed828f61b9c25bd4874cfb7b9d16f792
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c7d32359b9d76c79e6682389c3d478cfa42abdfe5cd16ac46fe77d280cece6d6
[INFO] running `Command { std: "docker" "start" "-a" "c7d32359b9d76c79e6682389c3d478cfa42abdfe5cd16ac46fe77d280cece6d6", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling semver v1.0.23
[INFO] [stderr]    Compiling walkdir v2.3.3
[INFO] [stderr]    Compiling rustix v0.38.31
[INFO] [stderr]    Compiling ucd-trie v0.1.6
[INFO] [stderr]    Compiling linux-raw-sys v0.4.13
[INFO] [stderr]    Compiling predicates-core v1.0.6
[INFO] [stderr]    Compiling fastrand v2.0.1
[INFO] [stderr]    Compiling pest v2.7.12
[INFO] [stderr]    Compiling clap_lex v0.6.0
[INFO] [stderr]    Compiling clap_builder v4.4.18
[INFO] [stderr]    Compiling float-cmp v0.9.0
[INFO] [stderr]    Compiling wait-timeout v0.2.0
[INFO] [stderr]    Compiling memfaultc-sys v1.26.1
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling termtree v0.4.1
[INFO] [stderr]    Compiling predicates-tree v1.0.9
[INFO] [stderr]    Compiling goblin v0.7.1
[INFO] [stderr]    Compiling rstest_macros v0.16.0
[INFO] [stderr]    Compiling predicates v2.1.5
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling memfaultd v1.26.1 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling rayon v1.10.0
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling pest_meta v2.7.12
[INFO] [stderr]    Compiling console v0.15.8
[INFO] [stderr]    Compiling tempfile v3.10.1
[INFO] [stderr]    Compiling pest_generator v2.7.12
[INFO] [stderr]    Compiling clap v4.4.18
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling rusty-forkfork v0.4.0
[INFO] [stderr]    Compiling sealed_test_derive v1.1.0
[INFO] [stderr]    Compiling linked-hash-map v0.5.6
[INFO] [stderr]    Compiling similar v2.6.0
[INFO] [stderr]    Compiling oorandom v11.1.4
[INFO] [stderr]    Compiling downcast v0.11.0
[INFO] [stderr]    Compiling fragile v2.0.0
[INFO] [stderr]    Compiling sealed_test v1.1.0
[INFO] [stderr]    Compiling approx v0.5.1
[INFO] [stderr]    Compiling criterion v0.5.1
[INFO] [stderr]    Compiling pest_derive v2.7.12
[INFO] [stderr]    Compiling insta v1.40.0
[INFO] [stderr]    Compiling strum_macros v0.24.3
[INFO] [stderr]    Compiling argh_derive v0.1.10
[INFO] [stderr]    Compiling mockall_derive v0.11.4
[INFO] [stderr]    Compiling argh v0.1.10
[INFO] [stderr]    Compiling rstest v0.16.0
[INFO] [stderr]    Compiling strum v0.24.1
[INFO] [stderr]    Compiling mockall v0.11.4
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 49s
[INFO] running `Command { std: "docker" "inspect" "c7d32359b9d76c79e6682389c3d478cfa42abdfe5cd16ac46fe77d280cece6d6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c7d32359b9d76c79e6682389c3d478cfa42abdfe5cd16ac46fe77d280cece6d6", kill_on_drop: false }`
[INFO] [stdout] c7d32359b9d76c79e6682389c3d478cfa42abdfe5cd16ac46fe77d280cece6d6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 0fb5135631856388d007d466aa1ddfbb4ab22d340e430c6f1e00b2a524484515
[INFO] running `Command { std: "docker" "start" "-a" "0fb5135631856388d007d466aa1ddfbb4ab22d340e430c6f1e00b2a524484515", kill_on_drop: false }`
[INFO] [stderr]    Compiling memfaultd v1.26.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 43.33s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/memfaultd-c8e53f31958e744a)
[INFO] [stdout] 
[INFO] [stdout] running 908 tests
[INFO] [stdout] test cli::memfault_core_handler::auxv::test::test_auxv_iterator::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::auxv::test::test_auxv_iterator::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::auxv::test::test_auxv_find_value ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_build_elf_note::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_build_elf_note::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_build_elf_note::case_5 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_build_elf_note::case_4 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_elf_note_try_parse_build_id_note ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_elf_note_try_parse_file_note_incomplete_string_table::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_elf_note_try_parse_file_note_incomplete_string_table::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_elf_note_try_parse_file_note_incomplete_string_table::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_elf_note_try_parse_file_note_too_short::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_build_elf_note::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::auxv::test::test_auxv_iterator::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_basic_edge_cases::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_elf_note_try_parse_file_note_too_short::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_basic_edge_cases::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_basic_edge_cases::case_4 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_empty ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_note_data_short::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_note_data_short::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_note_data_short::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_basic_edge_cases::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_note_parsing_failure_handling ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_basic_edge_cases::case_5 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_reader::test::test_read_segment_data::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_reader::test::test_read_program_headers::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_reader::test::test_read_program_headers::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_reader::test::test_read_segment_data::case_2 ... ok
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x5587ae8bd000
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x5587ae8be000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x5587ae8be000: failed to fill whole buffer
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x5587ae8bf000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x5587ae8bf000: failed to fill whole buffer
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x5587ae8c0000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x5587ae8c0000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x5587ae8c1000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x5587ae8c1000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38cb1000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38cb1000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38cb4000
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38cda000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38cda000: failed to fill whole buffer
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38e2f000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38e2f000: failed to fill whole buffer
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38e82000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38e82000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38e86000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38e86000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38e88000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38e88000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38e99000
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38ea9000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38ea9000: failed to fill whole buffer
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38f1c000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38f1c000: failed to fill whole buffer
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38f76000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38f76000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38f77000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38f77000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38f78000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38f78000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38f7a000
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38f7b000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38f7b000: failed to fill whole buffer
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38fa0000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38fa0000: failed to fill whole buffer
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38faa000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38faa000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7f6e38fac000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7f6e38fac000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7ffe4ba5b000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7ffe4ba5b000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7ffe4bb1b000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0x7ffe4bb1b000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x7ffe4bb1f000
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0xffffffffff600000
[INFO] [stderr] DEBUG Failed to collect metadata for Other("Unknown") @ 0xffffffffff600000: Invalid ELF header
[INFO] [stderr] DEBUG Detecting dynamic linker ranges from vaddr 0x5587ae8bd040
[INFO] [stdout] test cli::memfault_core_handler::core_elf_memfault_note::test::serialize_debug_data ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_writer::test::test_added_segments::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_writer::test::test_added_segments::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_writer::test::test_added_segments::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_writer::test::test_output_size_calculation::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_writer::test::test_output_size_calculation::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_writer::test::test_output_size_calculation::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_writer::test::test_output_size_calculation::case_4 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_writer::test::test_read_fail ... ok
[INFO] [stdout] test cli::memfault_core_handler::elf_utils::test::test_get_build_id ... ok
[INFO] [stdout] test cli::memfault_core_handler::elf_utils::test::test_get_section::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::elf_utils::test::test_get_section::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::elf_utils::test::test_get_section::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::elf_utils::test::test_get_section::case_4 ... ok
[INFO] [stdout] test cli::memfault_core_handler::elf_utils::test::test_section_header_read ... ok
[INFO] [stdout] test cli::memfault_core_handler::elf_utils::test::test_section_name_read ... ok
[INFO] [stdout] test cli::memfault_core_handler::elf_utils::test::test_verify_elf_header_fails_for_mismatching_arch::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::elf_utils::test::test_verify_elf_header_fails_for_mismatching_arch::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::elf_utils::test::test_verify_elf_header_fails_for_mismatching_arch::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_dynamic::test::test_dyn_iter::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_dynamic::test::test_dyn_iter::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_dynamic::test::test_dyn_iter::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_dynamic::test::test_find_c_string_region::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_dynamic::test::test_find_c_string_region::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_dynamic::test::test_find_c_string_region::case_3 ... ok
[INFO] [stderr] WARN Failed to read C-string at 0x1: failed to fill whole buffer
[INFO] [stdout] test cli::memfault_core_handler::find_dynamic::test::test_find_c_string_region::case_4 ... ok
[INFO] [stderr] DEBUG Detecting dynamic linker ranges from vaddr 0x5587ae8bd040
[INFO] [stdout] test cli::memfault_core_handler::find_dynamic::test::test_find_c_string_region::case_5 ... ok
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x0
[INFO] [stdout] test cli::memfault_core_handler::core_elf_memfault_note::test::test_serialize_metadata_as_map::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_memfault_note::test::test_serialize_metadata_as_map::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_memfault_note::test::test_serialize_metadata_as_map::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_dynamic::test::test_phdr_not_first_header ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_dynamic::test::test_find_dynamic_linker_ranges ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_elf_headers::test::test_ok_result_with_list_of_ranges ... ignored, FIXME: MFLT-11635 CoreElf .py requires ELF header + build ID in single segment
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x0
[INFO] [stdout] test cli::memfault_core_handler::find_elf_headers::test::test_err_result_if_no_elf ... ok
[INFO] [stderr] DEBUG Detecting ELF headers and build ID note ranges from vaddr 0x1000
[INFO] [stdout] test cli::memfault_core_handler::find_stack::test::test_stack_calculation::case_2_stack_descending ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_stack::test::test_stack_calculation::case_1_stack_ascending ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_stack::test::test_stack_not_found::case_1_below_regions ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_stack::test::test_stack_not_found::case_2_between_regions ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_stack::test::test_stack_not_found::case_3_above_regions ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_transformer::test::test_transform::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_elf_note::test::test_iterate_elf_notes_with_fixture ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_transformer::test::test_transform::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_elf_headers::test::test_err_result_if_missing_build_id ... ok
[INFO] [stdout] test cli::memfault_core_handler::find_elf_headers::test::test_ok_result_with_list_of_ranges_mflt_11635_work_around ... ok
[INFO] [stdout] test cli::memfault_core_handler::memory_range::test::test_memory_range_contains::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::memory_range::test::test_memory_range_contains::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::memory_range::test::test_memory_range_contains::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::log_wrapper::test::test_log_saving ... ok
[INFO] [stdout] test cli::memfault_core_handler::core_transformer::test::test_transform::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::memory_range::test::test_memory_range_merge::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::memory_range::test::test_memory_range_merge::case_4 ... ok
[INFO] [stdout] test cli::memfault_core_handler::memory_range::test::test_memory_range_merge::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_cfa_rule_parsing::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::eh_frame_finder::test::test_find_eh_frame ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_register_rule_parsing::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_register_access_expression ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_register_rule_parsing::case_1 ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_register_rule_parsing::case_3 ... ok
[INFO] [stderr] DEBUG Failed to get FDE: NoUnwindInfoForAddress
[INFO] [stderr] DEBUG Failed to find eh_frame for address: 0x4321
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_memory_access_expression ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_register_rule_parsing::case_4 ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_register_rule_parsing::case_6 ... ok
[INFO] [stdout] test cli::memfault_core_handler::memory_range::test::test_memory_range_merge::case_2 ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_no_fde_first_frame_falls_back_to_ra ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_register_rule_parsing::case_5 ... ok
[INFO] [stdout] test cli::memfault_core_handler::memory_range::test::test_memory_range_contains::case_4 ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_variable_size_mem_read::case_3 ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_variable_size_mem_read::case_4 ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_variable_size_mem_read::case_2 ... ok
[INFO] [stdout] test cli::memfaultctl::config_file::test::test_set_developer_mode::case_2 ... ok
[INFO] [stdout] test cli::memfaultctl::config_file::test::test_set_data_collection::case_3 ... ok
[INFO] [stdout] test cli::memfaultctl::config_file::test::test_set_data_collection::case_2 ... ok
[INFO] [stdout] test cli::memfaultctl::config_file::test::test_set_developer_mode::case_3 ... ok
[INFO] [stdout] test cli::memfaultctl::config_file::test::test_set_data_collection::case_4 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::invalid_key ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::invalid_value::case_1 ... ok
[INFO] [stdout] test cli::memfaultctl::config_file::test::test_set_data_collection::case_1 ... ok
[INFO] [stdout] test cli::memfaultctl::config_file::test::test_set_developer_mode::case_1 ... ok
[INFO] [stdout] test cli::memfaultctl::config_file::test::test_set_developer_mode::case_4 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::invalid_value::case_2 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::parsed_ok::case_1 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::parsed_ok::case_2 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::parsed_ok::case_3 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::parsed_ok::case_4 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::parsed_ok::case_6 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::parsed_ok::case_5 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::split_failed::case_2 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::parsed_ok::case_9 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::parsed_ok::case_8 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::parsed_ok::case_7 ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::split_failed::case_3 ... ok
[INFO] [stderr] TRACE Received JSON: [{"values":[0],"dstypes":["derive"],"dsnames":["value"],"time":1619712000.000,"interval":10.000,"host":"localhost","plugin":"cpu","plugin_instance":"0","type":"cpu","type_instance":"idle"}]
[INFO] [stderr] TRACE Received JSON: [{"values":[0],"dstypes":["derive"],"dsnames":["value"],"time":1619712000.000,"interval":10.000,"host":"localhost","plugin":"cpu","plugin_instance":"0","type":"cpu","type_instance":"idle"}]
[INFO] [stderr] TRACE Received JSON: [{"values":[0],"dstypes":["derive"],"dsnames":["value"],"time":1619712000.000,"interval":10.000,"host":"localhost","plugin":"cpufreq","plugin_instance":"0","type":"cpu","type_instance":"idle"}]
[INFO] [stderr] TRACE Received JSON: [{"values":[0],"dstypes":["derive"],"dsnames":["value"],"time":1619712000.000,"interval":10.000,"host":"localhost","plugin":"cpu","plugin_instance":"0","type":"cpu","type_instance":"idle"}]
[INFO] [stderr] TRACE Received JSON: [{"values":[0],"dstypes":["derive"],"dsnames":["value"],"time":1619712000.000,"interval":10.000,"host":"localhost","plugin":"mockplugin","plugin_instance":"0","type":"mock","type_instance":"test"}]
[INFO] [stderr] TRACE Received JSON: [{"values":[0],"dstypes":["derive"],"dsnames":["value"],"time":1619712000.000,"interval":10.000,"host":"localhost","plugin":"processes","plugin_instance":"0","type":"memfaultd","type_instance":"utime"}]
[INFO] [stderr] TRACE Received JSON: [{"values":[0],"dstypes":["derive"],"dsnames":["value"],"time":1619712000.000,"interval":10.000,"host":"localhost","plugin":"interface","plugin_instance":"0","type":"wlan0","type_instance":"bytes_tx"}]
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwind_handler::test::test_unwind_stack ... ok
[INFO] [stdout] test cli::memfaultctl::write_attributes::tests::split_failed::case_1 ... ok
[INFO] [stdout] test collectd::collectd_handler::tests::ignores_data_when_data_collection_is_off ... ok
[INFO] [stdout] test cli::show_settings::tests::test ... ok
[INFO] [stdout] test collectd::collectd_handler::tests::handle_push ... ok
[INFO] [stdout] test cli::memfault_core_handler::stack_unwinder::unwinder::test::test_variable_size_mem_read::case_1 ... ok
[INFO] [stdout] test collectd::payload::tests::convert_collectd_to_metric_name::case_2 ... ok
[INFO] [stdout] test collectd::payload::tests::convert_collectd_to_metric_name::case_3 ... ok
[INFO] [stdout] test collectd::payload::tests::convert_collectd_to_metric_name::case_1 ... ok
[INFO] [stdout] test collectd::payload::tests::convert_collectd_to_metric_name::case_4 ... ok
[INFO] [stdout] test collectd::payload::tests::convert_collectd_to_metric_name::case_5 ... ok
[INFO] [stdout] test collectd::collectd_handler::tests::drops_cpu_metrics_when_builtin_system_metrics_are_enabled ... ok
[INFO] [stdout] test collectd::payload::tests::convert_collectd_to_metric_name::case_6 ... ok
[INFO] [stdout] test collectd::payload::tests::convert_collectd_payload_into_heartbeat_metadata::case_3 ... ok
[INFO] [stdout] test collectd::collectd_handler::tests::drops_enabled_metrics_when_builtin_system_metrics_are_partially_enabled ... ok
[INFO] [stdout] test collectd::payload::tests::convert_collectd_payload_into_heartbeat_metadata::case_4 ... ok
[INFO] [stdout] test collectd::payload::tests::convert_collectd_payload_into_heartbeat_metadata::case_2 ... ok
[INFO] [stdout] test collectd::payload::tests::convert_collectd_payload_into_heartbeat_metadata::case_1 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_02 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_01 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_03 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_07 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_06 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_04 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_08 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_05 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_13 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_12 ... ok
[INFO] [stdout] test config::config_file::test::test_merge ... ok
[INFO] [stdout] test config::config_file::test::test_merge_overwrite_nested ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_14 ... ok
[INFO] [stdout] test config::config_file::test::test_merge_overwrite ... ok
[INFO] [stdout] test config::config_file::test::test_merge_overwrite_with_null ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_15 ... ok
[INFO] [stdout] test config::config_file::test::will_reject_bad_config::case_1 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_09 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_11 ... ok
[INFO] [stdout] test config::config_file::test::test_set_and_write_bool_to_runtime_config::case_1 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_10 ... ok
[INFO] [stdout] test config::config_file::test::test_set_and_write_bool_to_runtime_config::case_2 ... ok
[INFO] [stdout] test config::config_file::test::can_parse_test_files::case_16 ... ok
[INFO] [stdout] test config::config_file::test::test_set_and_write_bool_to_runtime_config::case_3 ... ok
[INFO] [stdout] test config::config_file::test::will_reject_bad_config::case_2 ... ok
[INFO] [stdout] test config::config_file::test::will_reject_bad_config::case_4 ... ok
[INFO] [stdout] test config::device_config::test::test_device_config_from_response ... ok
[INFO] [stdout] test config::config_file::test::will_reject_bad_config::case_3 ... ok
[INFO] [stdout] test config::device_info::tests::test_no_default_calls_with_device_info ... ok
[INFO] [stdout] test config::device_info::tests::test_empty ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_device_id::case_1_default_with_no_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_device_id::case_2_default_with_whitespace ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_device_id::case_3_default_with_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_device_id::case_4_no_default_with_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_hardware_version::case_3_default_with_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_hardware_version::case_4_no_default_with_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_sw_type::case_2_default_with_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_device_id::case_5_no_default_no_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_sw_type::case_3_no_default_with_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_hardware_version::case_1_default_with_no_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_hardware_version::case_2_default_with_whitespace ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_hardware_version::case_5_no_default_no_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_sw_type::case_1_default_with_no_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_swv::case_4_no_default_no_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_no_device_info ... ok
[INFO] [stdout] test config::device_info::tests::test_with_sw_version_and_type::case_2 ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_sw_type::case_4_no_default_no_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_swv::case_1_default_with_no_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_sw_version_and_type::case_3 ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_swv::case_2_default_with_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_sw_version_and_type::case_1 ... ok
[INFO] [stdout] test config::device_info::tests::test_with_default_swv::case_3_no_default_with_response ... ok
[INFO] [stdout] test config::device_info::tests::test_with_warnings ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_config_defaults_and_overrides::case_2 ... ok
[INFO] [stdout] test config::tests::do_not_generate_mar_device_config_if_not_needed ... ok
[INFO] [stdout] test config::tests::legacy_key_names::case_2 ... ok
[INFO] [stdout] test config::tests::legacy_key_names::case_1 ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_config_is_optional ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_config_defaults_and_overrides::case_3 ... ok
[INFO] [stdout] test config::tests::legacy_key_names::case_3 ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_config_defaults_and_overrides::case_4 ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_config_with_zlib_compression ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_config_defaults_and_overrides::case_1 ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_config_with_gzip_compression ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_config_with_no_compression ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_config_serialization_roundtrip ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_log_compression::case_3 ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_log_compression::case_2 ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_log_compression::case_1 ... ok
[INFO] [stdout] test config::tests::linux_custom_trace_log_compression::case_4 ... ok
[INFO] [stdout] test config::tests::log_attr_merge::case_3_logs_set ... ok
[INFO] [stdout] test config::tests::log_attr_merge::case_1_both_set ... ok
[INFO] [stdout] test config::tests::log_max_buffered_precedence::case_2 ... ok
[INFO] [stdout] test config::tests::log_attr_merge::case_4_neither_set ... ok
[INFO] [stdout] test config::tests::log_attr_merge::case_2_fluentd_set ... ok
[INFO] [stdout] test config::tests::mar_logs_clean_type::case_2 ... ok
[INFO] [stdout] test config::tests::generate_mar_device_config_confirmation_when_needed ... ok
[INFO] [stdout] test config::tests::log_attr_merge::case_5_duplicates ... ok
[INFO] [stdout] test config::tests::log_max_buffered_precedence::case_1 ... ok
[INFO] [stdout] test config::tests::mar_logs_clean_type::case_1 ... ok
[INFO] [stdout] test config::tests::software_type_precedence::case_2 ... ok
[INFO] [stdout] test config::tests::mar_logs_clean_type::case_3 ... ok
[INFO] [stdout] test config::tests::software_type_precedence::case_1 ... ok
[INFO] [stdout] test config::tests::software_type_precedence::case_3 ... ok
[INFO] [stdout] test config::tests::software_type_precedence::case_5 ... ok
[INFO] [stdout] test config::tests::software_version_precedence::case_1 ... ok
[INFO] [stdout] test config::tests::software_version_precedence::case_3 ... ok
[INFO] [stdout] test config::tests::software_type_precedence::case_4 ... ok
[INFO] [stdout] test config::tests::software_version_precedence::case_5 ... ok
[INFO] [stdout] test config::tests::software_type_precedence::case_6 ... ok
[INFO] [stdout] test config::tests::software_version_precedence::case_2 ... ok
[INFO] [stdout] test config::tests::software_version_precedence::case_4 ... ok
[INFO] [stdout] test config::tests::software_version_precedence::case_6 ... ok
[INFO] [stdout] test config::tests::test_info_overrides_file ... ok
[INFO] [stdout] test config::tests::tmp_folder_set ... ok
[INFO] [stdout] test config::utils::tests::device_id_is_valid_works::case_1 ... ok
[INFO] [stdout] test fluent_bit::decode_time::tests::decode_encoded_time::case_1 ... ok
[INFO] [stdout] test config::utils::tests::device_id_is_valid_works::case_2 ... ok
[INFO] [stdout] test config::utils::tests::device_id_is_valid_works::case_3 ... ok
[INFO] [stdout] test config::utils::tests::device_id_is_valid_works::case_4 ... ok
[INFO] [stdout] test config::utils::tests::device_id_is_valid_works::case_5 ... ok
[INFO] [stdout] test config::utils::tests::device_id_is_valid_works::case_6 ... ok
[INFO] [stdout] test fluent_bit::decode_time::tests::decode_encoded_time::case_3 ... ok
[INFO] [stdout] test fluent_bit::decode_time::tests::decode_encoded_time::case_4 ... ok
[INFO] [stdout] test fluent_bit::decode_time::tests::decode_ext_invalid_tag ... ok
[INFO] [stdout] test fluent_bit::decode_time::tests::decode_ext_buffer_too_small ... ok
[INFO] [stdout] test fluent_bit::decode_time::tests::decode_encoded_time::case_2 ... ok
[INFO] [stdout] test config::tests::tmp_dir_defaults_to_persist_dir ... ok
[INFO] [stdout] test logs::headroom::tests::log_upon_enter_and_exit_headroom_space_shortage ... ok
[INFO] [stdout] test logs::headroom::tests::log_upon_enter_and_exit_headroom_node_shortage ... ok
[INFO] [stdout] test logs::headroom::tests::retry_rotate_after_failure ... ok
[INFO] [stdout] test logs::headroom::tests::returns_true_if_headroom_ok_and_stays_ok ... ok
[INFO] [stdout] test logs::headroom::tests::rotate_once_only_during_headroom_shortage ... ok
[INFO] [stderr] WARN FluentD decoding error: Syntax("invalid type: integer `98`, expected tuple struct FluentdMessage")
[INFO] [stdout] test fluent_bit::tests::deserialize_timestamp_with_metadata ... ok
[INFO] [stdout] test logs::headroom::tests::rotate_once_only_entering_headroom_shortage ... ok
[INFO] [stdout] test fluent_bit::tests::deserialize_bogus_message ... ok
[INFO] [stdout] test logs::headroom::tests::write_error_of_initial_warning_message_is_ignored ... ok
[INFO] [stdout] test logs::headroom::tests::write_error_of_recovery_log_message_is_bubbled_up ... ok
[INFO] [stdout] test logs::journald_parser::test::test_from_raw_journal_entry ... ok
[INFO] [stdout] test http_server::request_bodies::tests::test_trace_args_json_roundtrip ... ok
[INFO] [stdout] test logs::journald_parser::test::test_load_cursor_empty_file ... ok
[INFO] [stdout] test logs::journald_parser::test::test_journal_happy_path ... ok
[INFO] [stdout] test logs::journald_provider::test::test_happy_path::case_1 ... ok
[INFO] [stdout] test logs::journald_provider::test::test_channel_dropped ... ok
[INFO] [stdout] test logs::journald_provider::test::test_happy_path::case_2 ... ok
[INFO] [stdout] test logs::log_collector::tests::delete_files_that_are_not_uuids ... ok
[INFO] [stdout] test fluent_bit::tests::deserialize_one_message ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpj29zcC/94aaa046-8d30-43af-a48a-7e7451e6fffc.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmp7Og46l/04b5b452-e3a9-4666-ae18-4dd3e89d6e80.log.zlib
[INFO] [stderr] WARN Too many lines captured in coredump (1000), clamping to 500
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpj29zcC/56476629-cf69-4c95-b81b-5de51e4044d4.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpi6UMS6/d8e9e3d9-75ac-4d0a-99b8-b8dfac6ad357.log.zlib
[INFO] [stderr] WARN Dropping log due to failed on_log_completion callback: on_log_completion failure!
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpj29zcC/09bca1ff-728e-4b25-a5a3-5409abb78ced.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpzYg8Kn/f7239f16-3cb7-4fb0-b2b3-86ead4a2c157.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpj29zcC/82b7bcf7-85e2-43af-b3ba-af46391c2d4b.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpzYg8Kn/b915273c-bea9-4e36-bfe6-e2a103239d01.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpi6UMS6/c73e6fc1-e87e-4ab2-9e3c-1ed593fbdf51.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpj29zcC/42bd6388-41dc-42ee-ac71-d276b7087e8d.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpi6UMS6/221cdd58-80d7-466c-a143-a6cfecf674cf.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpj29zcC/5af98307-2100-46b8-8c95-1007fef4288b.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpzYg8Kn/78d977e3-470f-4e38-97b0-0aa87a15fe3d.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpbol5YQ/4f4c99b6-d137-4613-97d0-9670016bd900.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpzYg8Kn/27e0a594-0051-4125-a6aa-0e18e7bbf1c3.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpLmx3vL/dd286fc0-94d1-4c3a-af23-5fef8cd9129e.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpDUyRjU/ae1b3775-e14e-4163-95b8-62236a249de1.log.zlib
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpLmx3vL/e725d0a3-b9bc-44bc-9d1b-1279bf56fa4b.log.zlib
[INFO] [stdout] test logs::log_collector::tests::device_config_update_message_handler ... ok
[INFO] [stdout] test logs::log_collector::tests::clamp_coredump_log_count ... ok
[INFO] [stdout] test fluent_bit::tests::deserialize_two_concatenated_messages ... ok
[INFO] [stdout] test logs::log_collector::tests::delete_log_after_failed_on_completion_callback ... ok
[INFO] [stdout] test logs::log_collector::tests::entry_sender_fail_counter_inc ... ok
[INFO] [stdout] test logs::log_collector::tests::circular_log_queue::case_2 ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpzYg8Kn/d1a78a12-0e6d-434d-987a-1998d4dcfe55.log.zlib
[INFO] [stdout] test logs::log_collector::tests::circular_log_queue::case_1 ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpJEkQgW/37dfb47f-e999-4b69-8fea-37359ffde461.log.zlib
[INFO] [stdout] test logs::log_collector::tests::forced_rotation_with_empty_log ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpzYg8Kn/29a7e005-8c50-4665-a4f6-a9439126c61a.log.zlib
[INFO] [stdout] test logs::log_collector::tests::forced_rotation_with_write_after_rotate ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmp9DuCIf/92240930-9d14-4854-8106-a415f1186e44.log.zlib
[INFO] [stdout] test logs::log_collector::tests::http_handler_unsupported_method::case_3 ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpzYg8Kn/bcf0c86b-493b-4313-b22f-23a9e8bb6b66.log.zlib
[INFO] [stdout] test logs::log_collector::tests::http_handler_unsupported_method::case_2 ... ok
[INFO] [stderr] DEBUG Recovering logfile: "/tmp/.tmpVjtrU1/46557832-4725-4e9a-8f1f-6e5432251a77.log.zlib"
[INFO] [stdout] test logs::log_collector::tests::forced_rotation_with_nonempty_log ... ok
[INFO] [stderr] DEBUG Recovering logfile: "/tmp/.tmpW35HRC/19baf9fc-2887-418d-b61e-af8bc0a44895.log.zlib"
[INFO] [stdout] test logs::log_collector::tests::http_handler_unsupported_method::case_4 ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpW35HRC/51dcd28a-5998-421b-8873-7446fe04f5b6.log.zlib
[INFO] [stdout] test logs::log_collector::tests::http_handler_log_get ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpGmZFRA/bd582956-3bc2-474d-917e-c8ec40dba057.log.zlib
[INFO] [stdout] test fluent_bit::tests::deserialize_one_message_received_in_two_parts ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpiqASBM/18c76c0c-4199-485d-8ea9-d222dcbb52c9.log.zlib
[INFO] [stdout] test logs::log_collector::tests::do_not_create_newfile_on_close ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpkCaeGv/f60bf096-106a-4e98-85ad-e1d2d981d82f.log.zlib
[INFO] [stdout] test logs::log_collector::tests::log_persistence::case_2 ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpzYg8Kn/a472afc2-f5e4-4952-bccc-3cb0b79986ee.log.zlib
[INFO] [stdout] test logs::log_collector::tests::recover_old_logfiles ... ok
[INFO] [stderr] TRACE Now writing logs to: /tmp/.tmpzYg8Kn/da21b5f0-13c3-449b-8611-303db7e1941b.log.zlib
[INFO] [stdout] test logs::log_collector::tests::http_handler_unsupported_method::case_1 ... ok
[INFO] [stdout] test logs::log_collector::tests::unhandled_url ... ok
[INFO] [stdout] test logs::log_entry::tests::test_filtering::case_2 ... ok
[INFO] [stdout] test logs::log_entry::tests::test_filtering::case_1 ... ok
[INFO] [stdout] test logs::log_collector::tests::recover_old_logfiles_on_entry ... ok
[INFO] [stdout] test logs::log_entry::tests::test_filtering::case_3 ... ok
[INFO] [stdout] test logs::log_entry::tests::test_filtering::case_4 ... ok
[INFO] [stdout] test logs::log_collector::tests::log_persistence::case_1 ... ok
[INFO] [stdout] test logs::log_filter::tests::no_rules_default_action::case_2 ... ok
[INFO] [stdout] test logs::log_filter::tests::no_rules_default_action::case_1 ... ok
[INFO] [stdout] test logs::log_collector::tests::circular_log_queue::case_3 ... ok
[INFO] [stdout] test logs::log_collector::tests::write_logs_to_disk ... ok
[INFO] [stdout] test logs::log_filter::tests::rule_match_message_pattern_overrides_default::case_1 ... ok
[INFO] [stdout] test logs::log_filter::tests::rule_match_message_pattern_overrides_default::case_2 ... ok
[INFO] [stdout] test logs::log_filter::tests::rule_match_service_overrides_default::case_2 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules::case_3 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules::case_1 ... ok
[INFO] [stdout] test logs::log_filter::tests::rule_match_service_overrides_default::case_1 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules::case_2 ... ok
[INFO] [stdout] test logs::log_filter::tests::rule_match_priority_overrides_default::case_2 ... ok
[INFO] [stdout] test logs::log_filter::tests::rule_match_priority_overrides_default::case_1 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules::case_4 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules_with_device_config ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules::case_5 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules_with_extra_fields::case_1 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules_with_extra_fields::case_2 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules_with_log_to_metrics::case_2 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules_with_log_to_metrics::case_2 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_complex_regex::case_1 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules::case_7 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules_with_log_to_metrics::case_3 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules_with_log_to_metrics::case_4 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_default_fallthrough::default_level_2_1 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_default_fallthrough::default_level_3_2 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules_with_log_to_metrics::case_1 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_default_fallthrough::default_level_7_6 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_default_fallthrough::default_level_4_3 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_default_fallthrough::default_level_5_4 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_default_fallthrough::default_level_8_7 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_level_match_happy_path::case_2 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_level_match_happy_path::case_3 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_level_match_happy_path::case_4 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_level_match_happy_path::case_1 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_level_match_happy_path::case_5 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_level_match_happy_path::case_7 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_level_match_happy_path::case_8 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_level_match_happy_path::case_6 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_default_fallthrough::default_level_6_5 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_match_extraction::case_1 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_match_extraction::case_3 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_level_precedence ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_match_extraction::case_4 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_match_extraction::case_5 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_no_match ... ok
[INFO] [stderr] DEBUG LogToMetrics: Processing log: LogEntry { ts: 2026-03-30T04:39:20.287557919Z, data: LogData { message: "session opened for user thomas(uid=1000)", pid: None, systemd_unit: None, priority: None, original_priority: None, extra_fields: {} } }
[INFO] [stderr] DEBUG LogToMetrics: Processing log: LogEntry { ts: 2026-03-30T04:39:20.287788499Z, data: LogData { message: "foo", pid: None, systemd_unit: None, priority: None, original_priority: None, extra_fields: {} } }
[INFO] [stderr] DEBUG LogToMetrics Pattern 'foo'=> MATCH=true Captures=Some(Captures({0: 0..3/"foo"}))
[INFO] [stdout] test logs::log_level_mapper::test::test_match_extraction::case_2 ... ok
[INFO] [stderr] DEBUG LogToMetrics: Processing log: LogEntry { ts: 2026-03-30T04:39:20.289073609Z, data: LogData { message: "docker.service: Scheduled restart job, restart counter is at 1.", pid: None, systemd_unit: None, priority: None, original_priority: None, extra_fields: {} } }
[INFO] [stderr] DEBUG LogToMetrics Pattern '(.*): Scheduled restart job, restart counter is at'=> MATCH=true Captures=Some(Captures({0: 0..60/"docker.service: Scheduled restart job, restart counter is at", 1: 0..14/"docker.service"}))
[INFO] [stdout] test logs::log_to_metrics::tests::test_log_to_metrics::case_1 ... ok
[INFO] [stdout] test logs::log_to_metrics::tests::test_log_to_metrics::case_3 ... ok
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules_with_log_to_metrics::case_3 ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_default_fallthrough::default_level_1_0 ... ok
[INFO] [stderr] DEBUG LogToMetrics: Processing log: LogEntry { ts: 2026-03-30T04:39:20.301755379Z, data: LogData { message: "Out of memory: Killed process 423 (wefaultd) total-vm:553448kB, anon-rss:284496kB, file-rss:0kB, shmem-rss:0kB, UID:0 pgtables:624kB oom_score_adj:0", pid: None, systemd_unit: None, priority: None, original_priority: None, extra_fields: {} } }
[INFO] [stderr] DEBUG LogToMetrics: Processing log: LogEntry { ts: 2026-03-30T04:39:20.301846329Z, data: LogData { message: "docker.service: Scheduled restart job, restart counter is at 1.", pid: None, systemd_unit: None, priority: None, original_priority: None, extra_fields: {"_SYSTEMD_UNIT": String("")} } }
[INFO] [stderr] DEBUG LogToMetrics: Processing log: LogEntry { ts: 2026-03-30T04:39:20.301765519Z, data: LogData { message: "docker.service: Scheduled restart job, restart counter is at 1.", pid: None, systemd_unit: None, priority: None, original_priority: None, extra_fields: {"UNIT": String("systemd")} } }
[INFO] [stdout] test logs::log_to_metrics::tests::test_log_to_metrics::case_6 ... ok
[INFO] [stderr] DEBUG LogToMetrics: Processing log: LogEntry { ts: 2026-03-30T04:39:20.302443909Z, data: LogData { message: "docker.service: Scheduled restart job, restart counter is at 1.", pid: None, systemd_unit: None, priority: None, original_priority: None, extra_fields: {} } }
[INFO] [stderr] DEBUG LogToMetrics Pattern '(.*): Scheduled restart job, restart counter is at'=> MATCH=true Captures=Some(Captures({0: 0..60/"docker.service: Scheduled restart job, restart counter is at", 1: 0..14/"docker.service"}))
[INFO] [stdout] test logs::log_to_metrics::tests::test_log_to_metrics::case_5 ... ok
[INFO] [stdout] test logs::recovery::tests::chain_cids ... ok
[INFO] [stderr] DEBUG LogToMetrics Pattern 'Out of memory: Killed process \d+ \((.*)\)'=> MATCH=true Captures=Some(Captures({0: 0..44/"Out of memory: Killed process 423 (wefaultd)", 1: 35..43/"wefaultd"}))
[INFO] [stdout] test logs::log_to_metrics::tests::test_log_to_metrics::case_7 ... ok
[INFO] [stderr] DEBUG LogToMetrics Pattern '(.*): Scheduled restart job, restart counter is at'=> MATCH=true Captures=Some(Captures({0: 0..60/"docker.service: Scheduled restart job, restart counter is at", 1: 0..14/"docker.service"}))
[INFO] [stdout] test logs::recovery::tests::empty_logging_directory ... ok
[INFO] [stderr] DEBUG LogToMetrics: Processing log: LogEntry { ts: 2026-03-30T04:39:20.302445659Z, data: LogData { message: "sshd.service: Scheduled restart job, restart counter is at 1.", pid: None, systemd_unit: None, priority: None, original_priority: None, extra_fields: {} } }
[INFO] [stdout] test logs::recovery::tests::dont_use_non_trailing_empty_uuid_named_file_as_next_cid ... ok
[INFO] [stdout] test logs::recovery::tests::use_empty_trailing_uuid_named_file_as_next_cid ... ok
[INFO] [stderr] DEBUG LogToMetrics Pattern '(.*): Scheduled restart job, restart counter is at'=> MATCH=true Captures=Some(Captures({0: 0..58/"sshd.service: Scheduled restart job, restart counter is at", 1: 0..12/"sshd.service"}))
[INFO] [stderr] DEBUG LogToMetrics: Processing log: LogEntry { ts: 2026-03-30T04:39:20.302446289Z, data: LogData { message: "docker.service: Scheduled restart job, restart counter is at 2.", pid: None, systemd_unit: None, priority: None, original_priority: None, extra_fields: {} } }
[INFO] [stderr] DEBUG LogToMetrics Pattern '(.*): Scheduled restart job, restart counter is at'=> MATCH=true Captures=Some(Captures({0: 0..60/"docker.service: Scheduled restart job, restart counter is at", 1: 0..14/"docker.service"}))
[INFO] [stdout] test logs::recovery::tests::delete_improperly_named_files ... ok
[INFO] [stdout] test logs::syslog::tests::test_read_syslog_message::case_1 ... ok
[INFO] [stdout] test logs::log_to_metrics::tests::test_log_to_metrics::case_4 ... ok
[INFO] [stdout] test logs::syslog::tests::test_missing_timestamp ... ok
[INFO] [stderr] TRACE Cleaning MAR staging area...
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpi4ZjyA/tmp/5b321751-33f5-478a-bb76-032f41331992 (1671 bytes / 2 inodes, ~0 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpi4ZjyA/tmp/5b321751-33f5-478a-bb76-032f41331992 DiskSize { bytes: 1671, inodes: 2 }
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpi4ZjyA/persist/5002b44b-226a-465d-a74a-e855f46fe93b (1671 bytes / 2 inodes, ~0 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpi4ZjyA/persist/5002b44b-226a-465d-a74a-e855f46fe93b DiskSize { bytes: 1671, inodes: 2 }
[INFO] [stdout] test logs::log_filter::tests::test_filter_rules::case_6 ... ok
[INFO] [stdout] test logs::syslog::tests::test_read_syslog_message_no_year::case_1 ... ok
[INFO] [stdout] test mar::clean::test::cleans_tmp_and_persist_when_clean_all ... ok
[INFO] [stdout] test logs::syslog::tests::test_read_syslog_message_no_year::case_2 ... ok
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpOCMdRx/tmp/07558f78-7194-4824-aa5f-1249a446fcf1 (672 bytes / 2 inodes, ~86400 seconds old). Deletion reason: Entry quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpOCMdRx/tmp/07558f78-7194-4824-aa5f-1249a446fcf1 DiskSize { bytes: 672, inodes: 2 }
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpwQrFwo/tmp/73b49dfc-4bd1-46da-9d1b-1d77a2442688 (14 bytes / 1 inodes, ~0 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpwQrFwo/tmp/73b49dfc-4bd1-46da-9d1b-1d77a2442688 DiskSize { bytes: 14, inodes: 1 }
[INFO] [stdout] test mar::clean::test::deletes_mar_entry_when_over_max_count::case_2_max_entries_less_than ... ok
[INFO] [stdout] test mar::clean::test::corrupted_entry_cleaned ... ok
[INFO] [stdout] test mar::clean::test::deletes_mar_entry_when_over_max_count::case_1_max_entries_0 ... ok
[INFO] [stdout] test mar::chunks::chunk::tests::test_single_chunk_message ... ok
[INFO] [stdout] test logs::log_level_mapper::test::test_default_rules ... ok
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpYu8A64/tmp/c1990b54-8854-4f65-a4b4-617701dd0c6c (0 bytes / 0 inodes, ~0 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpHmLWfi/persist/b6e2d03f-1857-43ae-beeb-92cf8c217407 (0 bytes / 0 inodes, ~0 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpYu8A64/tmp/c1990b54-8854-4f65-a4b4-617701dd0c6c DiskSize { bytes: 0, inodes: 0 }
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpHmLWfi/persist/b6e2d03f-1857-43ae-beeb-92cf8c217407 DiskSize { bytes: 0, inodes: 0 }
[INFO] [stdout] test mar::clean::test::empty_staging_area ... ok
[INFO] [stdout] test mar::clean::test::empty_persist_directory_cleaned ... ok
[INFO] [stdout] test mar::clean::test::expired_entries_marked ... ok
[INFO] [stdout] test mar::clean::test::empty_directory_cleaned ... ok
[INFO] [stdout] test mar::clean::test::deletes_mar_entry_when_over_max_count::case_4_max_entries_greater_than ... ok
[INFO] [stdout] test mar::clean::test::keeps_mar_entry_when_max_age_is_zero ... ok
[INFO] [stdout] test mar::clean::test::keeps_recent_unfinished_mar_entry ... ok
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmp3ZhLAq/tmp/87f8bd80-fb9b-41ed-a0aa-b345b01de41a (10671 bytes / 2 inodes, ~120 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmp3ZhLAq/tmp/87f8bd80-fb9b-41ed-a0aa-b345b01de41a DiskSize { bytes: 10671, inodes: 2 }
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmp3ZhLAq/tmp/65b0ed9f-54b3-4a28-b174-5478100d5306 (10671 bytes / 2 inodes, ~30 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmp3ZhLAq/tmp/65b0ed9f-54b3-4a28-b174-5478100d5306 DiskSize { bytes: 10671, inodes: 2 }
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpJycANm/tmp/86ad80ff-77c8-4808-aebe-6042e766d09b (1695 bytes / 2 inodes, ~0 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpJycANm/tmp/86ad80ff-77c8-4808-aebe-6042e766d09b DiskSize { bytes: 1695, inodes: 2 }
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpCQ9gXW/tmp/f6556844-e9a2-4450-ab26-d777fdb76a70 (672 bytes / 2 inodes, ~0 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpCQ9gXW/tmp/f6556844-e9a2-4450-ab26-d777fdb76a70 DiskSize { bytes: 672, inodes: 2 }
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpk2SnXM/tmp/12ba0b8d-d527-43b9-b7c4-40ddd5ac78be (1025 bytes / 1 inodes, ~0 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpk2SnXM/tmp/12ba0b8d-d527-43b9-b7c4-40ddd5ac78be DiskSize { bytes: 1025, inodes: 1 }
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmp8HMTv5/tmp/325b5427-ea24-46d5-8f0f-77de628d40f1 (8671 bytes / 2 inodes, ~120 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmp8HMTv5/tmp/325b5427-ea24-46d5-8f0f-77de628d40f1 DiskSize { bytes: 8671, inodes: 2 }
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpz84Qft/tmp/051163c6-4564-4c6c-83dc-196d28365d5a (672 bytes / 2 inodes, ~0 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpz84Qft/tmp/051163c6-4564-4c6c-83dc-196d28365d5a DiskSize { bytes: 672, inodes: 2 }
[INFO] [stdout] test mar::clean::test::keeps_recent_mar_entry ... ok
[INFO] [stdout] test mar::clean::test::keeps_mar_entry_within_max_age ... ok
[INFO] [stdout] test mar::clean::test::deletes_mar_entry_when_over_max_count::case_3_max_entries_equal ... ok
[INFO] [stdout] test mar::clean::test::removes_entries_exceeding_max_total_size_by_age ... ok
[INFO] [stdout] test mar::clean::test::removes_mar_entry_exceeding_max_total_size ... ok
[INFO] [stdout] test mar::clean::test::removes_unfinished_mar_entry_exceeding_max_total_size ... ok
[INFO] [stdout] test mar::clean::test::removes_oldest_mar_entry_exceeding_max_total_size_when_multiple ... ok
[INFO] [stdout] test mar::clean::test::test_marks_quota_and_expired_entries ... ok
[INFO] [stdout] test mar::clean::test::test_marks_when_different_quotas_exceeded ... ok
[INFO] [stdout] test mar::clean::test::test_no_delete_reasons_when_within_quota ... ok
[INFO] [stdout] test mar::clean::test::test_oldest_marked_when_over_max_total_size::case_1 ... ok
[INFO] [stdout] test mar::clean::test::test_oldest_marked_when_over_max_total_size::case_2 ... ok
[INFO] [stdout] test mar::clean::test::removes_mar_entry_exceeding_min_headroom ... ok
[INFO] [stdout] test mar::clean::test::removes_mar_entry_exceeding_min_headroom_inodes ... ok
[INFO] [stdout] test mar::clean::test::test_collect_entries ... ok
[INFO] [stdout] test mar::config::test::test_final_staging_path::case_1 ... ok
[INFO] [stdout] test mar::clean::test::test_two_oldest_marked_when_under_min_headroom::case_2 ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmp6OB0gQ/tmp/0116e745-067c-4776-8e34-aad2f5146d72"
[INFO] [stderr] TRACE Adding "/tmp/.tmp6OB0gQ/tmp/a1f4a5cb-4542-4332-8c0d-88eaeb4af6cf"
[INFO] [stderr] DEBUG LogToMetrics Pattern 'session opened for user (\w*)\(uid='=> MATCH=true Captures=Some(Captures({0: 0..35/"session opened for user thomas(uid=", 1: 24..30/"thomas"}))
[INFO] [stdout] test logs::log_to_metrics::tests::test_log_to_metrics::case_2 ... ok
[INFO] [stdout] test mar::export::tests::answer_204_when_empty ... ok
[INFO] [stdout] test mar::config::test::test_final_staging_path::case_2 ... ok
[INFO] [stdout] test mar::export::tests::download_reset_on_cleanup ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpki6M5a/tmp/165174cf-66d9-4fe0-abb0-350f6d44d0b3"
[INFO] [stderr] TRACE Adding "/tmp/.tmp3Ee47Q/tmp/731ca0aa-908a-45d9-a052-da18b9572cb7"
[INFO] [stderr] TRACE Export delete called but no current content to delete.
[INFO] [stderr] TRACE Deleting MAR entries: ["/tmp/.tmp3Ee47Q/tmp/731ca0aa-908a-45d9-a052-da18b9572cb7"]
[INFO] [stderr] TRACE Adding "/tmp/.tmprkQ0cH/tmp/be061fb0-957c-4349-b148-9d88ba5caa09"
[INFO] [stdout] test mar::export::tests::files_should_be_deleted_with_etag ... ok
[INFO] [stdout] test mar::export::tests::error_404_for_deletes ... ok
[INFO] [stdout] test mar::export::tests::download_zip ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpIUoc2G/tmp/5a62c398-20c1-41fd-a521-07e1a7bc10dc"
[INFO] [stdout] test mar::export::tests::download_twice ... ok
[INFO] [stdout] test mar::export_format::tests::test_accept_header_parser::case_2 ... ok
[INFO] [stderr] TRACE Deleting MAR entries: ["/tmp/.tmpIUoc2G/tmp/5a62c398-20c1-41fd-a521-07e1a7bc10dc"]
[INFO] [stdout] test mar::export_format::tests::test_accept_header_parser::case_1 ... ok
[INFO] [stdout] test mar::export_format::tests::test_accept_header_parser::case_4 ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpIZ9mFd/tmp/1ceaacb8-54a5-47f2-9cc5-31bad7275628"
[INFO] [stderr] DEBUG Delete error - Wrong hash. Got bogus, expected 12059676678434155703
[INFO] [stdout] test mar::export::tests::files_should_be_deleted_without_etag ... ok
[INFO] [stdout] test mar::export_format::tests::test_accept_header_parser::case_3 ... ok
[INFO] [stdout] test mar::export::tests::files_should_not_delete_if_etag_does_not_match ... ok
[INFO] [stdout] test mar::manifest::tests::attribute_to_keyed_metric_reading::case_3 ... ok
[INFO] [stdout] test mar::manifest::tests::can_parse_test_manifests::case_1 ... ok
[INFO] [stdout] test mar::manifest::tests::attribute_to_keyed_metric_reading::case_1 ... ok
[INFO] [stdout] test mar::manifest::tests::attribute_to_keyed_metric_reading::case_2 ... ok
[INFO] [stdout] test mar::manifest::tests::can_parse_test_manifests::case_2 ... ok
[INFO] [stdout] test mar::manifest::tests::can_parse_test_manifests::case_4 ... ok
[INFO] [stdout] test mar::manifest::tests::can_parse_test_manifests::case_3 ... ok
[INFO] [stdout] test mar::manifest::tests::can_parse_test_manifests::case_6 ... ok
[INFO] [stdout] test mar::manifest::tests::correct_os_info_read ... ok
[INFO] [stdout] test mar::manifest::tests::can_parse_test_manifests::case_7 ... ok
[INFO] [stdout] test mar::manifest::tests::serialization_of_coredump::case_1 ... ok
[INFO] [stdout] test mar::manifest::tests::serialization_of_custom_reboot ... ok
[INFO] [stdout] test mar::manifest::tests::serialization_of_coredump::case_2 ... ok
[INFO] [stdout] test mar::manifest::tests::serialization_of_custom_unexpected_reboot ... ok
[INFO] [stdout] test mar::manifest::tests::serialization_of_device_configc ... ok
[INFO] [stdout] test mar::manifest::tests::serialization_of_linux_heartbeat ... ok
[INFO] [stdout] test mar::manifest::tests::serialization_of_log::case_1 ... ok
[INFO] [stdout] test mar::manifest::tests::can_parse_test_manifests::case_5 ... ok
[INFO] [stdout] test mar::manifest::tests::serialization_of_device_attributes ... ok
[INFO] [stdout] test mar::manifest::tests::serialization_of_reboot ... ok
[INFO] [stdout] test mar::manifest::tests::whitespace_trimmed_attribute::case_1 ... ok
[INFO] [stdout] test mar::manifest::tests::whitespace_trimmed_attribute::case_2 ... ok
[INFO] [stdout] test mar::manifest::tests::whitespace_trimmed_attribute::case_3 ... ok
[INFO] [stdout] test mar::manifest::tests::whitespace_trimmed_attribute::case_5 ... ok
[INFO] [stdout] test mar::manifest::tests::whitespace_trimmed_attribute::case_4 ... ok
[INFO] [stdout] test mar::mar_entry_builder::tests::attachment_outside_entry_dir_is_moved_into_entry_dir_upon_save ... ok
[INFO] [stdout] test mar::mar_entry::tests::collecting_from_empty_folder ... ok
[INFO] [stdout] test mar::manifest::tests::serialization_of_log::case_2 ... ok
[INFO] [stdout] test mar::mar_entry::tests::collecting_from_folder_with_partial_entries ... ok
[INFO] [stdout] test mar::mar_entry_builder::tests::cleans_up_entry_dir_when_save_was_not_called ... ok
[INFO] [stdout] test mar::mar_entry_builder::tests::can_estimate_size_of_a_mar_entry ... ok
[INFO] [stdout] test mar::mar_entry_builder::tests::create_attachment_inside_entry_dir ... ok
[INFO] [stdout] test mar::mar_entry_builder::tests::save_keeps_entry_dir_and_adds_manifest_json ... ok
[INFO] [stdout] test mar::mar_entry_builder::tests::entry_moved_to_persist_dir_on_save ... ok
[INFO] [stdout] test mar::upload::tests::collecting_from_folder_with_partial_entries ... ok
[INFO] [stdout] test mar::upload::tests::collecting_from_empty_folder ... ok
[INFO] [stdout] test mar::upload::tests::test_upload_data_retention_time::case_1 ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpqN0wat/tmp/1cb8067e-2aae-49fb-bbc5-11a6fca8c8f5"
[INFO] [stderr] TRACE Adding "/tmp/.tmpqN0wat/tmp/c6221758-c73c-4179-afda-551055748882"
[INFO] [stderr] TRACE Adding "/tmp/.tmpTp46VO/tmp/c91b8bb5-af4c-4ad5-a748-0b5b7f504b66"
[INFO] [stderr] TRACE Adding "/tmp/.tmpqN0wat/tmp/4cc97cdc-40af-493d-a45b-efbe57b6e7cc"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpTp46VO/tmp/c91b8bb5-af4c-4ad5-a748-0b5b7f504b66"] - deleting...
[INFO] [stdout] test mar::upload::tests::test_upload_data_start_time_device_config ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpOL9TVO/tmp/9be01960-8493-48e6-b1c4-e04b6ff94f8c"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpOL9TVO/tmp/9be01960-8493-48e6-b1c4-e04b6ff94f8c"] - deleting...
[INFO] [stderr] TRACE Adding "/tmp/.tmpTz11tB/tmp/7c7bfcab-2827-42f6-bdf2-3aa7fc83cd79"
[INFO] [stdout] test mar::upload::tests::new_mar_when_size_limit_is_reached ... ok
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpTz11tB/tmp/7c7bfcab-2827-42f6-bdf2-3aa7fc83cd79"] - deleting...
[INFO] [stdout] test mar::upload::tests::test_upload_data_retention_time::case_2 ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpME9f7d/tmp/c68a2448-c8a3-444b-9c4a-51a2e38c7da5"
[INFO] [stdout] test mar::upload::tests::test_upload_data_start_time_reboot ... ok
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpME9f7d/tmp/c68a2448-c8a3-444b-9c4a-51a2e38c7da5"] - deleting...
[INFO] [stdout] test mar::upload::tests::uploading_custom_data_recordings::case_4_high ... ok
[INFO] [stdout] test mar::upload::tests::uploading_device_attributes::case_1_off ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpMQUiXc/tmp/e62c122a-8743-4e6c-a39a-62369c577a02"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpMQUiXc/tmp/e62c122a-8743-4e6c-a39a-62369c577a02"] - deleting...
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmp17KkTL/tmp/5fa4ad06-0a08-4205-a692-6f85cb33a1f4 (672 bytes / 2 inodes, ~600 seconds old). Deletion reason: Disk quota
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmp17KkTL/tmp/5fa4ad06-0a08-4205-a692-6f85cb33a1f4 DiskSize { bytes: 672, inodes: 2 }
[INFO] [stdout] test mar::upload::tests::uploading_device_attributes::case_2_low ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpDTX55c/tmp/d2867985-0fce-475d-93ce-3ea6543b2fed"
[INFO] [stdout] test mar::upload::tests::uploading_custom_data_recordings::case_2_low ... ok
[INFO] [stdout] test mar::upload::tests::uploading_custom_data_recordings::case_1_off ... ok
[INFO] [stdout] test mar::upload::tests::uploading_custom_data_recordings::case_3_normal ... ok
[INFO] [stdout] test mar::clean::test::test_two_oldest_marked_when_under_min_headroom::case_1 ... ok
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpDTX55c/tmp/d2867985-0fce-475d-93ce-3ea6543b2fed"] - deleting...
[INFO] [stderr] TRACE Adding "/tmp/.tmpOTTsAN/persist/d14876ef-2db6-40f2-8f3e-a7e0ebd30ae3"
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpgz5yvE/tmp/ce3627d0-4194-4061-9bce-2427b1aa2277 (10671 bytes / 2 inodes, ~120 seconds old). Deletion reason: Disk quota
[INFO] [stdout] test mar::clean::test::removes_mar_entry_exceeding_max_age ... ok
[INFO] [stdout] test mar::upload::tests::uploading_device_attributes::case_3_normal ... ok
[INFO] [stdout] test mar::upload::tests::uploading_logs::case_1_off ... ok
[INFO] [stdout] test mar::upload::tests::uploading_empty_list ... ok
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_01_heartbeat_off ... ok
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpgz5yvE/tmp/ce3627d0-4194-4061-9bce-2427b1aa2277 DiskSize { bytes: 10671, inodes: 2 }
[INFO] [stderr] DEBUG Cleaning up MAR entry: /tmp/.tmpgz5yvE/tmp/47c5f24c-b73a-487c-bfa3-3363714bbad7 (10671 bytes / 2 inodes, ~30 seconds old). Deletion reason: Disk quota
[INFO] [stderr] TRACE Adding "/tmp/.tmpDf6QLD/tmp/5854e5f4-3e96-4d9c-94d7-d51a9bed94dc"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpDf6QLD/tmp/5854e5f4-3e96-4d9c-94d7-d51a9bed94dc"] - deleting...
[INFO] [stderr] DEBUG Removed MAR entry: /tmp/.tmpgz5yvE/tmp/47c5f24c-b73a-487c-bfa3-3363714bbad7 DiskSize { bytes: 10671, inodes: 2 }
[INFO] [stderr] TRACE Adding "/tmp/.tmpOTTsAN/tmp/0df2a56f-0626-4772-b7df-13bf90e0777e"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpOTTsAN/persist/d14876ef-2db6-40f2-8f3e-a7e0ebd30ae3", "/tmp/.tmpOTTsAN/tmp/0df2a56f-0626-4772-b7df-13bf90e0777e"] - deleting...
[INFO] [stdout] test mar::upload::tests::uploading_device_attributes::case_4_high ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpUwgzF7/tmp/37b7d2c8-8899-45a7-bea6-6f583210d909"
[INFO] [stderr] TRACE Adding "/tmp/.tmpjb9dMC/tmp/97ace7ba-0143-4d60-b4b5-d4547ba57884"
[INFO] [stdout] test mar::upload::tests::uploading_from_both_tmp_and_persist_dirs ... ok
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpjb9dMC/tmp/97ace7ba-0143-4d60-b4b5-d4547ba57884"] - deleting...
[INFO] [stdout] test mar::upload::tests::uploading_logs::case_2_low ... ok
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpUwgzF7/tmp/37b7d2c8-8899-45a7-bea6-6f583210d909"] - deleting...
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_03_heartbeat_normal ... ok
[INFO] [stdout] test mar::upload::tests::uploading_logs::case_3_normal ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpp72aVT/tmp/a61138f3-afb4-488b-a9b5-e52fd024c96c"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpp72aVT/tmp/a61138f3-afb4-488b-a9b5-e52fd024c96c"] - deleting...
[INFO] [stderr] TRACE Adding "/tmp/.tmpNpGeHB/tmp/db8ca291-4206-4b4a-b8c8-960f045c49ae"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpNpGeHB/tmp/db8ca291-4206-4b4a-b8c8-960f045c49ae"] - deleting...
[INFO] [stderr] TRACE Adding "/tmp/.tmpj96Ibf/tmp/9cf88e8f-6095-4b3f-9d72-b9e06d7efcc8"
[INFO] [stderr] TRACE Adding "/tmp/.tmp6ox7LI/tmp/17fa9787-706c-4603-8591-4890c323a25c"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmp6ox7LI/tmp/17fa9787-706c-4603-8591-4890c323a25c"] - deleting...
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpj96Ibf/tmp/9cf88e8f-6095-4b3f-9d72-b9e06d7efcc8"] - deleting...
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_05_daily_heartbeat_off ... ok
[INFO] [stdout] test mar::upload::tests::uploading_logs::case_4_high ... ok
[INFO] [stdout] test mar::clean::test::removes_entries_exceeding_min_headroom_size_by_age ... ok
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_02_heartbeat_low ... ok
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_04_heartbeat_high ... ok
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_07_daily_heartbeat_normal ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpaC2Zl5/tmp/cf3dfa94-3994-441e-87f2-8b349886f17a"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpaC2Zl5/tmp/cf3dfa94-3994-441e-87f2-8b349886f17a"] - deleting...
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_06_daily_heartbeat_low ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmp1EzIri/tmp/bf9edc22-1a22-4168-837f-641b764aec33"
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_11_session_normal ... ok
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_10_session_low ... ok
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_09_session_off ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpcnSZlc/tmp/4be4fd7d-4536-4fd4-9b5f-e392d4b5bbf2"
[INFO] [stderr] TRACE Adding "/tmp/.tmpP0LZrk/tmp/60d095b5-5799-43f9-af35-92f793480c40"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpcnSZlc/tmp/4be4fd7d-4536-4fd4-9b5f-e392d4b5bbf2"] - deleting...
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmp1EzIri/tmp/bf9edc22-1a22-4168-837f-641b764aec33"] - deleting...
[INFO] [stderr] TRACE Adding "/tmp/.tmpN2Q0i5/tmp/fad64ea1-6a89-474f-960f-02a708c8539c"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpN2Q0i5/tmp/fad64ea1-6a89-474f-960f-02a708c8539c"] - deleting...
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_08_daily_heartbeat_high ... ok
[INFO] [stdout] test mar::upload::tests::uploading_reboots::case_3_normal ... ok
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpP0LZrk/tmp/60d095b5-5799-43f9-af35-92f793480c40"] - deleting...
[INFO] [stdout] test mar::upload::tests::uploading_reboots::case_1_off ... ok
[INFO] [stdout] test mar::upload::tests::uploading_metric_reports::case_12_session_high ... ok
[INFO] [stdout] test mar::upload::tests::uploading_reboots::case_2_low ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_charging_state_parsing::case_1 ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpR1LWYT/tmp/7e6f67a3-0bac-4394-b19e-4ee49ee3ae49"
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmpR1LWYT/tmp/7e6f67a3-0bac-4394-b19e-4ee49ee3ae49"] - deleting...
[INFO] [stderr] TRACE Adding "/tmp/.tmp6OdxgT/tmp/a32f55a6-7ac6-4f7f-af13-c27b80da7a31"
[INFO] [stderr] DEBUG Invalid folder in MAR staging: Error parsing manifest file "/tmp/.tmpW3jSmy/tmp/8d18128e-6b0e-433c-b50c-45b7d80d8c6a/manifest.json"
[INFO] [stderr] 
[INFO] [stderr] Caused by:
[INFO] [stderr]     expected value at line 1 column 1
[INFO] [stderr] 
[INFO] [stderr] Location:
[INFO] [stderr]     src/mar/mar_entry.rs:99:14
[INFO] [stderr] TRACE Adding "/tmp/.tmpW3jSmy/tmp/dd5c5ca2-44c8-4fe4-bb28-fb19fc858d83"
[INFO] [stderr] TRACE Adding "/tmp/.tmp0dK1He/tmp/b4d3e90d-7c80-4588-96dd-4953a09d2402"
[INFO] [stderr] DEBUG Invalid folder in MAR staging: Error parsing manifest file "/tmp/.tmps5BzUE/tmp/51797808-c366-4ca4-b01b-3eac6c4276be/manifest.json"
[INFO] [stderr] 
[INFO] [stderr] Caused by:
[INFO] [stderr]     expected value at line 1 column 1
[INFO] [stderr] 
[INFO] [stderr] Location:
[INFO] [stderr]     src/mar/mar_entry.rs:99:14
[INFO] [stderr] DEBUG Invalid folder in MAR staging: Error parsing manifest file "/tmp/.tmpZfy3vN/tmp/5d4e57db-c617-4a78-8f85-9d4cde7723b6/manifest.json"
[INFO] [stderr] 
[INFO] [stderr] Caused by:
[INFO] [stderr]     expected value at line 1 column 1
[INFO] [stderr] 
[INFO] [stderr] Location:
[INFO] [stderr]     src/mar/mar_entry.rs:99:14
[INFO] [stderr] TRACE Uploaded ["/tmp/.tmp0dK1He/tmp/b4d3e90d-7c80-4588-96dd-4953a09d2402"] - deleting...
[INFO] [stderr] TRACE Adding "/tmp/.tmps5BzUE/tmp/dfa30fa5-bec4-4d4a-b0b1-d8521c62e0c4"
[INFO] [stderr] TRACE Adding "/tmp/.tmpZfy3vN/tmp/dc3e89c7-c60c-47e8-b0c5-2478ebd6f841"
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_charging_state_parsing::case_2 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_charging_state_parsing::case_3 ... ok
[INFO] [stdout] test mar::upload::tests::zipping_with_skipped_entries::case_2_unreadable_dir ... ok
[INFO] [stdout] test mar::upload::tests::zipping_with_skipped_entries::case_1_not_json ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_charging_state_parsing::case_5 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_charging_state_parsing::case_6 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_charging_state_parsing::case_7 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_01 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_02 ... ok
[INFO] [stdout] test mar::upload::tests::uploading_reboots::case_4_high ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_03 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_04 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_06 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_07 ... ok
[INFO] [stdout] test mar::upload::tests::zipping_with_skipped_entries::case_3_unreadable_manifest ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_09 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_08 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_10 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_11 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_12 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_13 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_14 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_15 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_update_metrics_soc_pct::case_02 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_update_metrics_soc_pct::case_01 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_update_metrics_soc_pct::case_03 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_update_metrics_soc_pct::case_04 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_update_metrics_soc_pct::case_05 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_update_metrics_soc_pct::case_06 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_update_metrics_soc_pct::case_08 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_update_metrics_soc_pct::case_09 ... ok
[INFO] [stdout] test metrics::battery::battery_reading_handler::tests::errors_when_body_is_invalid ... ok
[INFO] [stdout] test metrics::battery::battery_reading_handler::tests::handle_push ... ok
[INFO] [stdout] test metrics::battery::battery_reading_handler::tests::handle_push_of_multiple_readings::case_1 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_parse::case_05 ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpMjdNMX/tmp/6c890884-c89c-4226-bad5-f8f62fa83139"
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_update_metrics_soc_pct::case_07 ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_charging_state_parsing::case_4 ... ok
[INFO] [stderr] TRACE Adding "/tmp/.tmpMjdNMX/tmp/3862f1b7-bc9e-4849-b50d-2608341ddaa0"
[INFO] [stdout] test mar::upload::tests::zipping_two_entries ... ok
[INFO] [stdout] test metrics::battery::battery_monitor::tests::test_update_metrics_soc_pct::case_10 ... ok
[INFO] [stdout] test metrics::battery::battery_reading_handler::tests::handle_push_of_multiple_readings::case_2 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_find_sysfs_battery_entry_empty_directory ... ok
[INFO] [stdout] test metrics::battery::battery_reading_handler::tests::handle_push_of_multiple_readings::case_3 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_multiple_batteries_sorted ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_invalid_str::case_1 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_find_sysfs_battery_entry_no_battery ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_find_sysfs_battery_entry_invalid_type_file ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_invalid_str::case_2 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_find_sysfs_battery_entry_finds_battery ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_invalid_str::case_4 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_invalid_str::case_5 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_02 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_03 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_invalid_str::case_3 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_08 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_01 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_07 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_04 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_05 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_06 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_09 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_10 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_13 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_14 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_15 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_16 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_11 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_12 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_17 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_21 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_18 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_25 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_26 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_27 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_28 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_20 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_22 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_24 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_23 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_sysfs_battery_parser_reading::case_1 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_power_supply_type_from_valid_str::case_19 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_sysfs_battery_parser_reading::case_6 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_sysfs_battery_parser_reading::case_2 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_sysfs_battery_parser_reading::case_4 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_sysfs_battery_parser_reading::case_3 ... ok
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 3.0, timestamp: 2026-03-30T04:39:20.511730936Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 3.0, timestamp: 2026-03-30T04:39:20.511732126Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.511732336Z } }]
[INFO] [stdout] test metrics::connectivity::connectivity_monitor::tests::test_fully_disconnected ... ok
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 3.0, timestamp: 2026-03-30T04:39:20.512568316Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.512569136Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.512569366Z } }, KeyedMetricReading { name: "operational_crashes_memfaultd", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.512577376Z } }]
[INFO] [stdout] test metrics::connectivity::connectivity_monitor::tests::test_half_connected_half_disconnected ... ok
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 3.0, timestamp: 2026-03-30T04:39:20.512730146Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 2.0, timestamp: 2026-03-30T04:39:20.512730706Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.512730896Z } }, KeyedMetricReading { name: "operational_crashes_memfaultd", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.512735736Z } }]
[INFO] [stdout] test metrics::battery::sysfs::tests::test_sysfs_battery_parser_soh_missing_files ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_sysfs_battery_parser_reading::case_5 ... ok
[INFO] [stdout] test metrics::battery::sysfs::tests::test_sysfs_battery_parser_with_soh ... ok
[INFO] [stdout] test metrics::connectivity::report_sync_event_handler::tests::handle_sync_failure ... ok
[INFO] [stdout] test metrics::connectivity::report_sync_event_handler::tests::handle_sync_success ... ok
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.520703925Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.520706365Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.520706596Z } }]
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.520726185Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.520727545Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.520727796Z } }]
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.520934936Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.520935656Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.520935845Z } }]
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.520946845Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.520947625Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.520947856Z } }, KeyedMetricReading { name: "operational_crashes_memfaultd", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.520958056Z } }]
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.521099696Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.521100405Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.521100585Z } }]
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.521204556Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.521205176Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.521205365Z } }]
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 2.0, timestamp: 2026-03-30T04:39:20.521377565Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 2.0, timestamp: 2026-03-30T04:39:20.521378576Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 0.0, timestamp: 2026-03-30T04:39:20.521378836Z } }]
[INFO] [stderr] DEBUG Configured HRT rate limit is 2000 - capping at 1500 samples per minute
[INFO] [stdout] test metrics::connectivity::connectivity_monitor::tests::test_while_connected ... ok
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.529770955Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.529772165Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 4.0, timestamp: 2026-03-30T04:39:20.529772375Z } }, KeyedMetricReading { name: "operational_crashes_memfaultd", value: Counter { value: 3.0, timestamp: 2026-03-30T04:39:20.529785955Z } }, KeyedMetricReading { name: "operational_crashes_collectd", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.529789575Z } }]
[INFO] [stdout] test metrics::crashfree_interval::tests::test_180min_heartbeat_with_one_crash ... ok
[INFO] [stderr] TRACE Crashfree hours metrics: [KeyedMetricReading { name: "operational_hours", value: Counter { value: 120.0, timestamp: 2026-03-30T04:39:20.529864585Z } }, KeyedMetricReading { name: "operational_crashfree_hours", value: Counter { value: 60.0, timestamp: 2026-03-30T04:39:20.529865555Z } }, KeyedMetricReading { name: "operational_crashes", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.529865785Z } }, KeyedMetricReading { name: "operational_crashes_memfaultd", value: Counter { value: 1.0, timestamp: 2026-03-30T04:39:20.529871505Z } }]
[INFO] [stdout] test metrics::connectivity::report_sync_event_handler::tests::handle_multiple_sync_events ... ok
[INFO] [stdout] test mar::upload::tests::zipping_an_unreadable_attachment ... FAILED
[INFO] [stdout] test metrics::crashfree_interval::tests::test_30min_heartbeat ... ok
[INFO] [stdout] test metrics::crashfree_interval::tests::test_30min_heartbeat_with_crash ... ok
[INFO] [stdout] test metrics::crashfree_interval::tests::test_counting_hours ... ok
[INFO] [stdout] test metrics::crashfree_interval::tests::test_counting_intervals ... ok
[INFO] [stdout] test metrics::crashfree_interval::tests::test_counting_minutes ... ok
[INFO] [stdout] test metrics::crashfree_interval::tests::test_process_crash_counter ... ok
[INFO] [stdout] test metrics::hrt::schema::test::test_datum_conversion::case_1 ... ok
[INFO] [stdout] test metrics::hrt::schema::test::test_datum_conversion::case_2 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::fail_on_invalid_statsd_reading::case_1 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::fail_on_invalid_statsd_reading::case_2 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::fail_on_invalid_statsd_reading::case_3 ... ok
[INFO] [stdout] test metrics::hrt::report::tests::test_hrt_report_rate_limiting ... ok
[INFO] [stdout] test metrics::hrt::schema::test::test_serialization ... ok
[INFO] [stdout] test metrics::hrt::schema::test::test_datum_conversion::case_3 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_statsd_key_with_legacy::case_1 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_statsd_key_with_legacy::case_2 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_statsd_key_with_legacy::case_3 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_statsd_key_with_legacy::case_4 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_arg_reading::case_1 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_arg_reading::case_3 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_arg_reading::case_2 ... ok
[INFO] [stdout] test metrics::hrt::schema::test::test_cdr_write ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_statsd_reading::case_01 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_statsd_reading::case_02 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_statsd_reading::case_03 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_statsd_reading::case_04 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_statsd_reading::case_05 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_statsd_reading::case_08 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_statsd_reading::case_09 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_statsd_reading::case_06 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_statsd_reading::case_07 ... ok
[INFO] [stdout] test metrics::metric_reading::tests::parse_valid_statsd_reading::case_10 ... ok
[INFO] [stdout] test metrics::metric_report::tests::empty_contains_nothing ... ok
[INFO] [stdout] test metrics::metric_report::tests::extend_merges_keys_from_both_sets ... ok
[INFO] [stdout] test metrics::metric_report::tests::extend_with_empty_is_noop ... ok
[INFO] [stdout] test metrics::metric_report::tests::from_metric_keys_empty_slice_is_empty ... ok
[INFO] [stdout] test metrics::metric_report::tests::from_metric_keys_contains_provided_keys ... ok
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics::case_3 ... ok
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics::case_5 ... ok
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics::case_2 ... ok
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics::case_1 ... ok
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics::case_7 ... ok
[INFO] [stdout] test metrics::hrt::report::tests::test_build_hrt_report ... ok
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics::case_4 ... ok
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics_session::case_3 ... ok
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics_session::case_2 ... ok
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'heartbeat':
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics_session::case_4 ... ok
[INFO] [stderr] TRACE {
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics_session::case_1 ... ok
[INFO] [stderr]   "bar": "2.0",
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics_session::case_5 ... ok
[INFO] [stderr]   "baz": "3.0",
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics_session::case_6 ... ok
[INFO] [stderr]   "foo": "1.0"
[INFO] [stdout] test metrics::metric_report::tests::test_boolean_metrics::case_1 ... ok
[INFO] [stderr] }
[INFO] [stdout] test metrics::metric_report::tests::test_empty_after_write ... ok
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "2.0",
[INFO] [stderr]   "baz": "3.0",
[INFO] [stderr]   "foo": "1.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'daily-heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "2.0",
[INFO] [stderr]   "baz": "3.0",
[INFO] [stderr]   "foo": "1.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stdout] test metrics::metric_report::tests::test_extra_histo_min_max::case_1 ... ok
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 1 metrics for report type 'heartbeat':
[INFO] [stdout] test metrics::metric_report::tests::test_extra_histo_min_max::case_2 ... ok
[INFO] [stderr] TRACE {
[INFO] [stdout] test metrics::metric_report::tests::test_aggregate_metrics::case_6 ... ok
[INFO] [stderr]   "foo": "1.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "baz": "1.5",
[INFO] [stderr]   "foo": "1.5"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "2.0",
[INFO] [stderr]   "foo": "1.5"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'daily-heartbeat':
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 1 metrics for report type 'heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "baz": "1.5",
[INFO] [stderr]   "foo": "1.5"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "2.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 1 metrics for report type 'daily-heartbeat':
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 1 metrics for report type 'heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "2.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "1.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.01s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.01s
[INFO] [stdout] test metrics::metric_report_manager::tests::test_heartbeat_report::case_2 ... ok
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 1 metrics for report type 'heartbeat':
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'test-session-some-metrics':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "2.0",
[INFO] [stderr]   "foo": "1.0",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "2.0",
[INFO] [stderr]   "baz": "3.0",
[INFO] [stderr]   "foo": "1.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'daily-heartbeat':
[INFO] [stdout] test metrics::metric_report_manager::tests::test_heartbeat_report::case_1 ... ok
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 1 metrics for report type 'daily-heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "2.0",
[INFO] [stderr]   "foo": "1.5"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.01s
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "1.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'test-session-all-metrics':
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE {
[INFO] [stderr]   "baz": "1.5",
[INFO] [stderr]   "foo": "1.5",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.01s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.01s
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "2.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.01s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.01s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.01s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 4 metrics for report type 'test-session-all-metrics':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "2.0",
[INFO] [stderr]   "baz": "3.0",
[INFO] [stderr]   "foo": "1.0",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.02s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.02s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 1 metrics for report type 'heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "1.5"
[INFO] [stderr] }
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'test-session-some-metrics':
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "1.0",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.01s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.01s
[INFO] [stdout] test metrics::metric_report_manager::tests::test_heartbeat_and_session_reports::case_1 ... ok
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'test-session-some-metrics':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "1.5",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.02s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'test-session-some-metrics':
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.02s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'test-session-all-metrics':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "2.0",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.02s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.02s
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "2.0",
[INFO] [stderr]   "foo": "1.5",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.01s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'test-session-all-metrics':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "1.0",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.02s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.02s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'test-session-some-metrics':
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.01s
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "2.0",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.02s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.02s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'test-session-all-metrics':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "2.0",
[INFO] [stderr]   "foo": "1.5",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.02s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.02s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 1 metrics for report type 'heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "foo": "1.6666666666666667"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stdout] test metrics::metric_report_manager::tests::test_heartbeat_report::case_4 ... ok
[INFO] [stdout] test metrics::metric_report_manager::tests::test_heartbeat_report::case_3 ... ok
[INFO] [stdout] test metrics::metric_report_manager::tests::test_heartbeat_and_session_reports::case_2 ... ok
[INFO] [stdout] test metrics::metric_report_manager::tests::test_heartbeat_and_session_reports::case_4 ... ok
[INFO] [stdout] test metrics::metric_report_manager::tests::test_heartbeat_and_session_reports::case_3 ... ok
[INFO] [stdout] test metrics::metric_report_manager::tests::test_heartbeat_and_session_reports::case_5 ... ok
[INFO] [stdout] test metrics::metric_report_manager::tests::test_heartbeat_report::case_5 ... ok
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'test-session':
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'test-session-start-twice':
[INFO] [stdout] test metrics::metric_report_manager::tests::test_no_daily_heartbeats_when_disabled ... ok
[INFO] [stderr] TRACE {
[INFO] [stdout] test metrics::metric_report_manager::tests::test_no_hrt_when_disabled::case_1 ... ok
[INFO] [stderr]   "bar": "3.5",
[INFO] [stderr]   "foo": "5.0",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stdout] test metrics::metric_report_manager::tests::test_sessions_capture_core_metrics::case_2 ... ok
[INFO] [stdout] test metrics::metric_report_manager::tests::test_sessions_capture_core_metrics::case_1 ... ok
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "3.5",
[INFO] [stderr]   "foo": "5.0",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "3.5",
[INFO] [stderr]   "foo": "5.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 2 metrics for report type 'daily-heartbeat':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "3.5",
[INFO] [stderr]   "foo": "5.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stdout] test metrics::metric_string_key::tests::parsed_ok::case_1 ... ok
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stdout] test metrics::metric_string_key::tests::validation_errors::case_1 ... ok
[INFO] [stdout] test metrics::metric_string_key::tests::validation_errors::case_2 ... ok
[INFO] [stdout] test metrics::metric_report_manager::tests::test_unconfigured_session_name_fails ... ok
[INFO] [stdout] test metrics::metric_string_key::tests::null_gets_removed ... ok
[INFO] [stdout] test metrics::metrics_event_handler::test::test_handle_request ... ok
[INFO] [stdout] test metrics::metrics_event_handler::test::test_handle_request_data_collection_disabled ... ok
[INFO] [stdout] test metrics::metrics_event_handler::test::test_parse_request ... ok
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 4 metrics for report type 'test-session':
[INFO] [stderr] TRACE {
[INFO] [stderr]   "bar": "20.0",
[INFO] [stderr]   "baz": "\"test-tag\"",
[INFO] [stderr]   "foo": "100.0",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] DEBUG Generated MAR entry from metrics: /tmp/.tmp2Io8JG/mar/a945cdf4-3ec4-40f3-959a-13102b718dfa
[INFO] [stdout] test metrics::metric_report_manager::tests::test_start_session_twice ... ok
[INFO] [stdout] test metrics::metric_report_manager::tests::test_prepare_all_prepares_sessions ... ok
[INFO] [stderr] TRACE 🔍 MEMFAULTD_DEBUG: Serializing 3 metrics for report type 'test-session':
[INFO] [stdout] test metrics::session_event_handler::tests::test_start_twice_without_stop_session ... ok
[INFO] [stderr] TRACE {
[INFO] [stdout] test metrics::session_event_handler::tests::test_start_then_stop_session ... ok
[INFO] [stderr]   "bar": "3.0",
[INFO] [stderr]   "foo": "1.0",
[INFO] [stderr]   "operational_crashes": "0.0"
[INFO] [stderr] }
[INFO] [stderr] TRACE 📊 Duration: 0.00s
[INFO] [stderr] TRACE ⏱️  Boottime duration: 0.00s
[INFO] [stderr] DEBUG Generated MAR entry from metrics: /tmp/.tmpOcqpUj/mar/97a86528-aff2-4a70-a3a4-23b8495d872b
[INFO] [stdout] test metrics::session_event_handler::tests::test_start_without_stop_session ... ok
[INFO] [stdout] test metrics::session_event_handler::tests::test_end_with_metrics ... ok
[INFO] [stdout] test metrics::session_name::tests::validation_errors::case_1 ... ok
[INFO] [stdout] test metrics::session_name::tests::validation_errors::case_2 ... ok
[INFO] [stdout] test metrics::session_name::tests::validation_errors::case_3 ... ok
[INFO] [stdout] test metrics::session_name::tests::parsed_ok::case_1 ... ok
[INFO] [stdout] test metrics::session_name::tests::parsed_ok::case_2 ... ok
[INFO] [stdout] test metrics::session_name::tests::validation_errors::case_5 ... ok
[INFO] [stdout] test metrics::statsd_server::test::test_process_statsd_message::case_1 ... ok
[INFO] [stdout] test metrics::metric_string_key::tests::parsed_ok::case_2 ... ok
[INFO] [stdout] test metrics::session_name::tests::validation_errors::case_4 ... ok
[INFO] [stdout] test metrics::statsd_server::test::test_process_statsd_message::case_3 ... ok
[INFO] [stdout] test metrics::session_event_handler::tests::test_start_with_metrics ... ok
[INFO] [stdout] test metrics::statsd_server::test::test_process_statsd_message::case_2 ... ok
[INFO] [stdout] test metrics::metric_report_manager::tests::test_hrt_when_enabled::case_1 ... ok
[INFO] [stdout] test metrics::statsd_server::test::test_process_statsd_message_with_legacy_gauge_aggregation::case_2 ... ok
[INFO] [stdout] test metrics::system_metrics::cpu::test::test_fails_on_invalid_proc_stat_line::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::cpu::test::test_fails_on_invalid_proc_stat_line::case_2 ... ok
[INFO] [stdout] test metrics::statsd_server::test::test_process_statsd_message_with_legacy_gauge_aggregation::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::cpu::test::test_fails_on_invalid_proc_stat_line::case_4 ... ok
[INFO] [stdout] test metrics::system_metrics::cpu::test::test_fails_on_invalid_proc_stat_line::case_3 ... ok
[INFO] [stdout] test metrics::system_metrics::cpu::test::test_process_valid_proc_stat_line::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::disk::test::test_calc_bytes_reading_overflow::case_2 ... ok
[INFO] [stdout] test metrics::system_metrics::disk::test::test_calc_bytes_reading_overflow::case_3 ... ok
[INFO] [stdout] test metrics::system_metrics::disk::test::test_calc_bytes_reading_overflow::case_4 ... ok
[INFO] [stdout] test metrics::system_metrics::disk::test::test_calc_bytes_reading_overflow::case_5 ... ok
[INFO] [stdout] test metrics::statsd_server::test::test_process_statsd_message::case_4 ... ok
[INFO] [stdout] test metrics::statsd_server::test::test_process_statsd_message::case_5 ... ok
[INFO] [stdout] test metrics::system_metrics::disk::test::test_get_disk_metrics ... ok
[INFO] [stderr] WARN bytes_written metric overflow for disk mmcblk0, discarding reading
[INFO] [stderr] DEBUG Invalid lifetime a pct
[INFO] [stderr] DEBUG Invalid lifetime b pct
[INFO] [stderr] DEBUG Invalid lifetime a pct
[INFO] [stderr] DEBUG Invalid lifetime b pct
[INFO] [stdout] test metrics::system_metrics::disk::test::test_get_tracked_disks::case_2 ... ok
[INFO] [stderr] DEBUG Underflow - lifetime a greater than 100
[INFO] [stdout] test metrics::system_metrics::disk::test::test_get_tracked_disks::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::disk::test::test_lifetime_interval_read ... ok
[INFO] [stdout] test metrics::system_metrics::disk::test::test_get_disk_metrics_without_lifetimes ... ok
[INFO] [stdout] test metrics::system_metrics::disk::test::get_disk_metrics_multiple_disks ... ok
[INFO] [stderr] WARN bytes_written metric overflow for disk mmcblk0, discarding reading
[INFO] [stdout] test metrics::system_metrics::disk::test::test_lifetime_metric_underflow ... ok
[INFO] [stdout] test metrics::system_metrics::disk::test::test_calc_bytes_reading_overflow::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::disk::test::test_lifetime_interval_update ... ok
[INFO] [stdout] test metrics::system_metrics::disk_space::test::test_disk_monitored::case_2 ... ok
[INFO] [stdout] test metrics::system_metrics::disk_space::test::test_disk_monitored::case_3 ... ok
[INFO] [stdout] test metrics::system_metrics::disk_space::test::test_process_valid_proc_mounts_line ... ok
[INFO] [stdout] test metrics::system_metrics::diskstats::test::test_process_valid_proc_stat_line::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::disk_space::test::test_disk_monitored::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::diskstats::test::test_unmonitored_disk_ignored::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::memory::test::test_fail_get_metrics_when_mem_total_is_zero ... ok
[INFO] [stdout] test metrics::system_metrics::memory::test::test_fail_get_metrics_with_bad_fmt ... ok
[INFO] [stdout] test metrics::system_metrics::diskstats::test::test_process_valid_proc_stat_line::case_2 ... ok
[INFO] [stdout] test metrics::system_metrics::cpu::test::test_cpu_metric_collector_calcs::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::memory::test::test_fail_to_parse_bad_meminfo_line ... ok
[INFO] [stdout] test metrics::system_metrics::disk_space::test::test_unmonitored_disks_not_initialized ... ok
[INFO] [stdout] test metrics::system_metrics::disk_space::test::test_initialize_and_calc_disk_space_for_mounts ... ok
[INFO] [stdout] test metrics::system_metrics::memory::test::test_fail_get_metrics_with_missing_required_lines ... ok
[INFO] [stdout] test metrics::system_metrics::diskstats::test::test_calculate_metrics::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::memory::test::test_parse_meminfo_line::case_2 ... ok
[INFO] [stdout] test metrics::system_metrics::memory::test::test_parse_meminfo_line::case_3 ... ok
[INFO] [stderr] WARN JEDEC spec before v5.0, lifetime values not available
[INFO] [stdout] test metrics::system_metrics::memory::test::test_parse_meminfo_line::case_5 ... ok
[INFO] [stderr] WARN Unable to read EXT_CSD register, lifetime values not available
[INFO] [stdout] test metrics::system_metrics::memory::test::test_parse_meminfo_line::case_4 ... ok
[INFO] [stderr] WARN No last tracked boot_id found
[INFO] [stdout] test metrics::system_metrics::memory::test::test_get_memory_metrics_no_memavailable ... ok
[INFO] [stderr] INFO Using reboot reason CustomRebootReason (expected reboot) from test source for boot_id df2b93a5-5ef1-45e4-b8e0-9a95c4d7d5fd
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_fails_on_invalid_proc_net_dev_line::case_1 ... ok
[INFO] [stderr] INFO Writing reboot reason to "/tmp/.tmpISqF7T/lastrebootreason"
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_fails_on_invalid_proc_net_dev_line::case_2 ... ok
[INFO] [stderr] WARN No last tracked boot_id found
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored::case_2 ... ok
[INFO] [stderr] INFO Using reboot reason 37888 (HardFault) from test source for boot_id df2b93a5-5ef1-45e4-b8e0-9a95c4d7d5fd
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored::case_1 ... ok
[INFO] [stderr] INFO Writing reboot reason to "/tmp/.tmpLHGE3X/lastrebootreason"
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored::case_3 ... ok
[INFO] [stderr] WARN No last tracked boot_id found
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored::case_4 ... ok
[INFO] [stderr] INFO Using reboot reason 37888 (HardFault) from main source for boot_id df2b93a5-5ef1-45e4-b8e0-9a95c4d7d5fd
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored_auto::case_1 ... ok
[INFO] [stderr] INFO Discarded reboot reason 2 (UserReset) from secondary source for boot_id df2b93a5-5ef1-45e4-b8e0-9a95c4d7d5fd
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored_auto::case_2 ... ok
[INFO] [stderr] INFO Writing reboot reason to "/tmp/.tmp67SyFH/lastrebootreason"
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored_auto::case_4 ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored_auto::case_5 ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored_auto::case_3 ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored_auto::case_8 ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored_auto::case_7 ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored_auto::case_9 ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_interface_is_monitored_auto::case_6 ... ok
[INFO] [stdout] test metrics::system_metrics::memory::test::test_parse_meminfo_line::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::memory::test::test_get_memory_metrics ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_parse_netwireless_line::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_parse_netdev_line::case_2 ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_net_if_metric_collector_calcs::case_2 ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_parse_netwireless_line::case_2 ... ok
[INFO] [stdout] test metrics::system_metrics::oui::tests::test_family_name ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_empty_arp_content ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_net_if_metric_collector_different_if::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_parse_netdev_line::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_empty_directory ... ok
[INFO] [stdout] test metrics::system_metrics::network_interfaces::test::test_net_if_metric_collector_calcs::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_extract_oui ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_get_wireless_ap_ouis ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_inactive_adapter_filtered ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_non_wireless_adapter_filtered ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_get_wireless_ap_ouis_json_snapshot ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_get_wireless_local_ouis ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_malformed_adapter_directory ... ok
[INFO] [stdout] test metrics::system_metrics::processes::tests::test_parse_single_line ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_malformed_arp_entries ... ok
[INFO] [stdout] test metrics::system_metrics::processes::tests::test_collect_metrics::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_non_wireless_device_filtered_from_arp ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_parse_arp_entry ... ok
[INFO] [stdout] test metrics::system_metrics::vm::tests::test_parse_vmstat_line ... ok
[INFO] [stdout] test metrics::session_event_handler::tests::test_stop_without_start_session ... ok
[INFO] [stdout] test metrics::system_metrics::vm::tests::test_parse_swap_stats ... ok
[INFO] [stdout] test metrics::system_metrics::vm::tests::test_real_vmstat_format ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_counter_aggregation::case_1 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_edge_values_aggregate::case_2 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_edge_values_aggregate::case_3 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_edge_values_new::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::processes::tests::test_process_stats_from_proc::case_1 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_edge_values_new::case_2 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_edge_values_new::case_3 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_gauge_aggregation::case_1 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_gauge_aggregation::case_2 ... ok
[INFO] [stdout] test metrics::system_metrics::processes::tests::test_process_stats_from_proc::case_2 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_histogram_aggregation::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::thermal::tests::test_read_thermal_zone_temp ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_histogram_aggregation::case_2 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_histogram_aggregation::case_3 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_histogram_aggregation::case_4 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_incompatible_metric_type_on_histogram ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_rssi_aggregation::case_1 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_rssi_aggregation::case_3 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_time_weighted_aggregation::case_2 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_time_weighted_aggregation::case_1 ... ok
[INFO] [stdout] test metrics::system_metrics::vm::tests::test_vm_metrics_calculation ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_rssi_aggregation::case_2 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_time_weighted_aggregation::case_3 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_time_weighted_aggregation::case_4 ... ok
[INFO] [stdout] test metrics::timeseries::tests::test_time_weighted_aggregation::case_5 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_available_jedec::case_1 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_available_jedec::case_2 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_available_jedec::case_4 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_available_sysfs::case_2 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_fetch_type ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_extcsd ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_01 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_02 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_03 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_04 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_05 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_06 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_07 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_08 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_10 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_11 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_raw_to_pct::case_1 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_raw_to_pct::case_2 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_available_sysfs::case_1 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_from_sysfs_string::case_09 ... ok
[INFO] [stdout] test mmc::test::test_read_jedec_revision ... ok
[INFO] [stdout] test mmc::test::test_lifetime_raw_to_pct::case_3 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_raw_to_pct::case_4 ... ok
[INFO] [stdout] test mmc::test::test_lifetime_available_jedec::case_3 ... ok
[INFO] [stdout] test network::requests::test::test_device_config_missing_upload_start ... ok
[INFO] [stdout] test network::requests::test::test_device_config_with_memfaultd_empty_logs ... ok
[INFO] [stdout] test network::requests::test::test_device_config ... ok
[INFO] [stdout] test network::requests::test::test_device_config_with_memfaultd ... ok
[INFO] [stdout] test network::requests::test::test_unknown_device_config_field_deserialize ... ok
[INFO] [stdout] test network::requests::test::test_device_config_with_memfaultd_empty_memfaultd ... ok
[INFO] [stdout] test network::requests::test::test_device_config_with_memfaultd_empty_sdk_settings ... ok
[INFO] [stdout] test metrics::system_metrics::oui_parse::tests::test_get_wireless_local_ouis_json_snapshot ... ok
[INFO] [stdout] test network::requests::test::test_prepare_upload_serialization ... ok
[INFO] [stdout] test retriable_error::tests::test_ignore_non_retriable_errors_with::case_2 ... ok
[INFO] [stdout] test retriable_error::tests::test_ignore_non_retriable_errors_with::case_3 ... ok
[INFO] [stdout] test retriable_error::tests::test_ignore_non_retriable_errors_with::case_1 ... ok
[INFO] [stdout] test trace::save_trace_handler::tests::test_compress_log_file_handles_io_error ... ok
[INFO] [stdout] test reboot::test::test_reboot_reason_parsing ... ok
[INFO] [stdout] test trace::save_trace_handler::tests::test_compress_log_file_creates_compressed_file ... ok
[INFO] [stdout] test trace::save_trace_handler::tests::test_compression_preserves_file_name_pattern ... ok
[INFO] [stdout] test reboot::test::test_custom_reboot_reason_parsing ... ok
[INFO] [stdout] test trace::save_trace_handler::tests::test_dump_log_buffer_calls_compress_with_config ... ok
[INFO] [stdout] test trace::save_trace_handler::tests::test_compression_with_no_compression ... ok
[INFO] [stdout] test trace::save_trace_handler::tests::test_compression_with_empty_log_file ... ok
[INFO] [stdout] test util::can_connect::tests::test_unreachable_ip_errors ... ok
[INFO] [stdout] test util::can_connect::tests::test_localhost_reachable ... ok
[INFO] [stdout] test util::circular_queue::test::empty_pop ... ok
[INFO] [stdout] test trace::save_trace_handler::tests::test_compression_with_zlib_encoder ... ok
[INFO] [stdout] test reboot::test::test_reboot_reason_source_ordering ... ok
[INFO] [stdout] test util::circular_queue::test::test_ring_buffer ... ok
[INFO] [stdout] test util::circular_queue::test::test_wrap_around ... ok
[INFO] [stdout] test trace::save_trace_handler::tests::test_large_log_file_compression ... ok
[INFO] [stdout] test util::disk_backed::tests::test_defaults_to_default ... ok
[INFO] [stdout] test util::disk_backed::tests::test_load_from_disk ... ok
[INFO] [stdout] test trace::save_trace_handler::tests::test_rate_limiting ... ok
[INFO] [stdout] test util::disk_backed::tests::test_write_with_change ... ok
[INFO] [stdout] test util::disk_size::tests::test_size_cmp::case_1 ... ok
[INFO] [stdout] test util::disk_backed::tests::test_write_without_change ... ok
[INFO] [stdout] test util::disk_backed::tests::test_write_with_no_existing_file_and_new_equals_default ... ok
[INFO] [stdout] test util::disk_backed::tests::test_write_with_corrupted_local_file ... ok
[INFO] [stdout] test util::disk_size::tests::test_size_cmp::case_3 ... ok
[INFO] [stdout] test util::disk_size::tests::test_size_cmp::case_5 ... ok
[INFO] [stdout] test util::disk_size::tests::test_size_cmp::case_4 ... ok
[INFO] [stdout] test util::disk_size::tests::test_size_cmp::case_2 ... ok
[INFO] [stdout] test util::disk_size::tests::test_size_cmp::case_6 ... ok
[INFO] [stdout] test util::etc_os_release::test::test_id_parse::case_2_id_without_quotes ... ok
[INFO] [stdout] test util::etc_os_release::test::test_id_parse::case_1_id_with_quotes ... ok
[INFO] [stdout] test util::etc_os_release::test::test_id_parse::case_3_no_id ... ok
[INFO] [stdout] test util::etc_os_release::test::test_version_id_parse::case_1_version_with_quotes ... ok
[INFO] [stdout] test util::fs::tests::test_move_dir_rename_success ... ok
[INFO] [stdout] test util::fs::tests::test_copy_dir_target_inside_source_is_error ... ok
[INFO] [stdout] test util::io::test::test_forward_seeker_seek_fail::case_1 ... ok
[INFO] [stdout] test util::io::test::test_forward_seeker_seek_fail::case_2 ... ok
[INFO] [stdout] test util::fs::tests::test_move_dir_target_inside_source_is_error ... ok
[INFO] [stdout] test util::io::test::test_forward_seeker_seek_fail::case_3 ... ok
[INFO] [stdout] test util::io::test::test_forward_seeker_stream ... ok
[INFO] [stdout] test util::io::test::test_write_cursor ... ok
[INFO] [stdout] test util::io::test::test_write_vectored_cursor ... ok
[INFO] [stdout] test util::fs::tests::test_copy_dir_contents ... ok
[INFO] [stdout] test util::path::tests::test_file_prefix::case_2 ... ok
[INFO] [stdout] test util::path::tests::test_file_prefix::case_3 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_is_valid::case_2 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_is_valid::case_1 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_is_valid::case_3 ... ok
[INFO] [stdout] test util::disk_backed::tests::test_write_with_no_existing_file_and_new_is_not_default ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_is_valid::case_4 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_is_valid::case_5 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_spaces_parens_slash_is_valid::case_1 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_is_valid::case_6 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_spaces_parens_slash_is_valid::case_2 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_spaces_parens_slash_is_valid::case_3 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_spaces_parens_slash_is_valid::case_4 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_spaces_parens_slash_is_valid::case_5 ... ok
[INFO] [stdout] test util::patterns::tests::test_alphanum_slug_dots_colon_spaces_parens_slash_is_valid::case_6 ... ok
[INFO] [stdout] test util::persistent_rate_limiter::tests::invalid_init::case_1_invalid_count ... ok
[INFO] [stdout] test util::persistent_rate_limiter::tests::invalid_init::case_2_invalid_duration ... ok
[INFO] [stdout] test util::etc_os_release::test::test_version_id_parse::case_2_version_without_quotes ... ok
[INFO] [stdout] test util::etc_os_release::test::test_version_id_parse::case_3_no_version ... ok
[INFO] [stdout] test util::path::tests::test_file_prefix::case_1 ... ok
[INFO] [stdout] test util::persistent_rate_limiter::tests::test_rate_limiter::case_1 ... ok
[INFO] [stdout] test util::persistent_rate_limiter::tests::test_rate_limiter::case_2 ... ok
[INFO] [stdout] test util::persistent_rate_limiter::tests::test_rate_limiter::case_3 ... ok
[INFO] [stdout] test util::rate_limiter::tests::test_bursty_start ... ok
[INFO] [stderr] TRACE Sleep for 3599.97s
[INFO] [stdout] test util::rate_limiter::tests::test_reject_burst ... ok
[INFO] [stderr] TRACE Sleep for 3599.85s
[INFO] [stdout] test util::serialization::kib_to_usize::tests::serialize_error ... ok
[INFO] [stderr] WARN Error in Memfaultd main loop: invocation failed
[INFO] [stdout] test util::serialization::kib_to_usize::tests::serialize_multiple_of_1024 ... ok
[INFO] [stderr] TRACE Sleep for 59.99s
[INFO] [stdout] test metrics::timeseries::tests::test_edge_values_aggregate::case_1 ... ok
[INFO] [stderr] TRACE Sleep for 3599.97s
[INFO] [stdout] test util::rate_limiter::tests::test_sustained_100_per_minute ... ok
[INFO] [stderr] WARN Error in Memfaultd main loop: invocation failed
[INFO] [stdout] test util::string::test::test_capitalize::case_1 ... ok
[INFO] [stderr] TRACE Sleep for 59.99s
[INFO] [stdout] test util::string::test::test_capitalize::case_2 ... ok
[INFO] [stderr] WARN Error in Memfaultd main loop: invocation failed
[INFO] [stdout] test util::string::test::test_remove_comments ... ok
[INFO] [stderr] TRACE Sleep for 119.97s
[INFO] [stdout] test util::system::test::test_cmdline_parsing::case_1 ... ok
[INFO] [stderr] WARN Error in Memfaultd main loop: invocation failed
[INFO] [stdout] test util::system::test::test_cmdline_parsing::case_2 ... ok
[INFO] [stderr] TRACE Sleep for 239.97s
[INFO] [stdout] test util::system::test::test_cmdline_parsing::case_3 ... ok
[INFO] [stderr] TRACE Sleep for 3599.97s
[INFO] [stdout] test util::task::tests::test_loop_with_exponential_backoff::case_1_everything_ok ... ok
[INFO] [stderr] WARN Error in Memfaultd main loop: invocation failed
[INFO] [stdout] test util::task::tests::test_loop_with_exponential_backoff::case_2_errors_are_retried_sooner ... ok
[INFO] [stderr] TRACE Sleep for 59.97s
[INFO] [stdout] test util::string::test::truncate_with_ellipsis::case_3 ... ok
[INFO] [stderr] WARN Error in Memfaultd main loop: invocation failed
[INFO] [stdout] test util::task::tests::test_loop_with_exponential_backoff::case_3_long_runs_will_rerun_immediately ... ok
[INFO] [stdout] test util::task::tests::test_loop_with_exponential_backoff::case_5_can_rerun_immediately ... ok
[INFO] [stdout] test util::task::tests::test_loop_with_exponential_backoff::case_4_errors_retry_backoff ... ok
[INFO] [stdout] test util::wildcard_pattern::tests::test_matches::case_1 ... ok
[INFO] [stdout] test util::wildcard_pattern::tests::test_matches::case_3 ... ok
[INFO] [stdout] test util::wildcard_pattern::tests::test_matches::case_2 ... ok
[INFO] [stdout] test util::wildcard_pattern::tests::test_matches::case_4 ... ok
[INFO] [stdout] test util::wildcard_pattern::tests::test_nonmatches_do_not_match::case_1 ... ok
[INFO] [stdout] test util::wildcard_pattern::tests::test_nonmatches_do_not_match::case_3 ... ok
[INFO] [stdout] test util::wildcard_pattern::tests::test_nonmatches_do_not_match::case_2 ... ok
[INFO] [stdout] test util::zip::tests::test_empty ... ok
[INFO] [stdout] test util::string::test::truncate_with_ellipsis::case_1 ... ok
[INFO] [stdout] test util::string::test::truncate_with_ellipsis::case_2 ... ok
[INFO] [stdout] test util::zip::tests::test_basic ... ok
[INFO] [stdout] test util::persistent_rate_limiter::tests::test_rate_limiter::case_4 ... ok
[INFO] [stdout] test util::string::test::truncate_with_ellipsis::case_4 - should panic ... ok
[INFO] [stdout] test logs::log_file::tests::test_write_without_corruption ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- mar::upload::tests::zipping_an_unreadable_attachment stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'mar::upload::tests::zipping_an_unreadable_attachment' (657) panicked at src/mar/upload.rs:342:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: 1
[INFO] [stdout]  right: 0
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x58150e1bb38a - std[ec4e911328de40a6]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x58150e1bb38a - std[ec4e911328de40a6]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec4e911328de40a6]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x58150e1bb38a - std[ec4e911328de40a6]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x58150e1bb38a - <<std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a96a4c5c53f902a3]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x58150e1d57ba - <core[a96a4c5c53f902a3]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x58150e1d57ba - core[a96a4c5c53f902a3]::fmt::write
[INFO] [stdout]    6:     0x58150e1c0a22 - std[ec4e911328de40a6]::io::default_write_fmt::<alloc[c960326de6de28e6]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x58150e1c0a22 - <alloc[c960326de6de28e6]::vec::Vec<u8> as std[ec4e911328de40a6]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x58150e1946af - <std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x58150e1946af - std[ec4e911328de40a6]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x58150e1b0d79 - std[ec4e911328de40a6]::panicking::default_hook
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x58150db9eafc - <alloc[c960326de6de28e6]::boxed::Box<dyn for<'a, 'b> core[a96a4c5c53f902a3]::ops::function::Fn<(&'a std[ec4e911328de40a6]::panic::PanicHookInfo<'b>,), Output = ()> + core[a96a4c5c53f902a3]::marker::Sync + core[a96a4c5c53f902a3]::marker::Send> as core[a96a4c5c53f902a3]::ops::function::Fn<(&std[ec4e911328de40a6]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x58150db9eafc - test[30c43f9fd66fea90]::test_main_with_exit_callback::<test[30c43f9fd66fea90]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x58150e1b0f32 - <alloc[c960326de6de28e6]::boxed::Box<dyn for<'a, 'b> core[a96a4c5c53f902a3]::ops::function::Fn<(&'a std[ec4e911328de40a6]::panic::PanicHookInfo<'b>,), Output = ()> + core[a96a4c5c53f902a3]::marker::Sync + core[a96a4c5c53f902a3]::marker::Send> as core[a96a4c5c53f902a3]::ops::function::Fn<(&std[ec4e911328de40a6]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x58150e1b0f32 - std[ec4e911328de40a6]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x58150e194768 - std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x58150e18bbd9 - std[ec4e911328de40a6]::sys::backtrace::__rust_end_short_backtrace::<std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x58150e1958ed - __rustc[aa69f48705c57ca8]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x58150e1d602c - core[a96a4c5c53f902a3]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x58150e1d5eb3 - core[a96a4c5c53f902a3]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panicking.rs:439:17
[INFO] [stdout]   20:     0x58150e1cecfd - core[a96a4c5c53f902a3]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x58150d8c0408 - memfaultd[f7e1ad80ddf98972]::mar::upload::tests::zipping_an_unreadable_attachment::zipping_an_unreadable_attachment
[INFO] [stdout]                                at /opt/rustwide/workdir/src/mar/upload.rs:342:9
[INFO] [stdout]   22:     0x58150d8a5776 - memfaultd[f7e1ad80ddf98972]::mar::upload::tests::zipping_an_unreadable_attachment
[INFO] [stdout]                                at /opt/rustwide/workdir/src/mar/upload.rs:331:5
[INFO] [stdout]   23:     0x58150d88fee7 - memfaultd[f7e1ad80ddf98972]::mar::upload::tests::zipping_an_unreadable_attachment::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/mar/upload.rs:331:14
[INFO] [stdout]   24:     0x58150d622956 - <memfaultd[f7e1ad80ddf98972]::mar::upload::tests::zipping_an_unreadable_attachment::{closure#0} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x58150db92bdb - <fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x58150db92bdb - test[30c43f9fd66fea90]::__rust_begin_short_backtrace::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x58150db9f5cb - test[30c43f9fd66fea90]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x58150db9f5cb - <core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x58150db9f5cb - std[ec4e911328de40a6]::panicking::catch_unwind::do_call::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}>, core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x58150db9f5cb - std[ec4e911328de40a6]::panicking::catch_unwind::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x58150db9f5cb - std[ec4e911328de40a6]::panic::catch_unwind::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}>, core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x58150db9f5cb - test[30c43f9fd66fea90]::run_test_in_process
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x58150db9f5cb - test[30c43f9fd66fea90]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x58150db9ace4 - test[30c43f9fd66fea90]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x58150db9ace4 - std[ec4e911328de40a6]::sys::backtrace::__rust_begin_short_backtrace::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x58150dba21d2 - std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x58150dba21d2 - <core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x58150dba21d2 - std[ec4e911328de40a6]::panicking::catch_unwind::do_call::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x58150dba21d2 - std[ec4e911328de40a6]::panicking::catch_unwind::<(), core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x58150dba21d2 - std[ec4e911328de40a6]::panic::catch_unwind::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x58150dba21d2 - std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x58150dba21d2 - <std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x58150e1ba0cf - <alloc[c960326de6de28e6]::boxed::Box<dyn core[a96a4c5c53f902a3]::ops::function::FnOnce<(), Output = ()> + core[a96a4c5c53f902a3]::marker::Send> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   44:     0x58150e1ba0cf - <std[ec4e911328de40a6]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7707ddb7baa4 - <unknown>
[INFO] [stdout]   46:     0x7707ddc08a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     mar::upload::tests::zipping_an_unreadable_attachment
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 906 passed; 1 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.92s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "0fb5135631856388d007d466aa1ddfbb4ab22d340e430c6f1e00b2a524484515", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0fb5135631856388d007d466aa1ddfbb4ab22d340e430c6f1e00b2a524484515", kill_on_drop: false }`
[INFO] [stdout] 0fb5135631856388d007d466aa1ddfbb4ab22d340e430c6f1e00b2a524484515
